"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/03 02:43:37 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-nobumul9kemu"
2025/05/03 02:43:37 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/03 02:43:37 DEBUG : Creating backend with remote "TestBox:rclone-test-nobumul9kemu"
2025/05/03 02:43:38 DEBUG : box root 'rclone-test-nobumul9kemu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/03 02:43:38 DEBUG : box root 'rclone-test-nobumul9kemu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/03 02:43:40 INFO  : dir: Making directory
2025/05/03 02:43:41 INFO  : dir/subdir1: Making directory
2025/05/03 02:43:42 INFO  : dir/subdir3: Making directory
2025/05/03 02:43:42 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724968503")
2025/05/03 02:43:42 DEBUG : box root 'rclone-test-nobumul9kemu': ["hello world2"(0)|file|ITEM_UPLOAD|1851953917499|a47994e3eaa1f6c3919683002da61c47f51036a9] new parent not found
2025/05/03 02:43:42 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:42 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724969731")
2025/05/03 02:43:43 INFO  : dir/subdir2: Making directory
2025/05/03 02:43:43 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724969967")
2025/05/03 02:43:43 DEBUG : box root 'rclone-test-nobumul9kemu': ["ignore dir"(0)|folder|ITEM_CREATE|319543622388|9dcd39b364c2d442d6c6afca974e7c777835e3f4] new parent not found
2025/05/03 02:43:43 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:43 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724970730")
2025/05/03 02:43:44 DEBUG : box root 'rclone-test-nobumul9kemu': [".ignore"(0)|file|ITEM_UPLOAD|1851947462253|aaeadadafa797534cf35066c42c8e2fc69ffd25f] new parent not found
2025/05/03 02:43:44 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:44 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724970970")
2025/05/03 02:43:44 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724971202")
2025/05/03 02:43:45 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724971734")
2025/05/03 02:43:45 DEBUG : box root 'rclone-test-nobumul9kemu': ["rclone-test-nobumul9kemu"(0)|folder|ITEM_CREATE|319543302513|b8783463446ad4f4a269b5979dbf48dba709b948] new parent not found
2025/05/03 02:43:45 DEBUG : box root 'rclone-test-nobumul9kemu': ["should be ignored"(0)|file|ITEM_UPLOAD|1851952734252|2378ac4ff859e03326dec278ca26ac09ac697220] new parent not found
2025/05/03 02:43:45 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:45 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724972728")
2025/05/03 02:43:46 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724972963")
2025/05/03 02:43:47 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724973729")
2025/05/03 02:43:47 DEBUG : box root 'rclone-test-nobumul9kemu': ["sub sub dir"(0)|folder|ITEM_CREATE|319542253411|861bd4e258d5c02b50d5431674c067be7b398781] new parent not found
2025/05/03 02:43:47 DEBUG : box root 'rclone-test-nobumul9kemu': ["dir"(0)|folder|ITEM_CREATE|319543666889|3c76fa3b0dd8bb039ac5fe0c4e8dea3fa183c6fc] added new path ("dir") for notify
2025/05/03 02:43:47 DEBUG : doChangeNotify("dir", 0)
2025/05/03 02:43:47 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/03 02:43:47 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724974733")
2025/05/03 02:43:48 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724974975")
2025/05/03 02:43:48 DEBUG : box root 'rclone-test-nobumul9kemu': ["subdir1"(0)|folder|ITEM_CREATE|319542602133|a52df1334456c0eb81b4fcae61b793b40972ca86] added new path ("dir/subdir1") for notify
2025/05/03 02:43:48 DEBUG : box root 'rclone-test-nobumul9kemu': ["hello world3"(0)|file|ITEM_UPLOAD|1851954261541|2e4ce2c18a967374b67dc057856419b26a7f4155] new parent not found
2025/05/03 02:43:48 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/03 02:43:48 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/03 02:43:48 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724975730")
2025/05/03 02:43:49 DEBUG : box root 'rclone-test-nobumul9kemu': ["subdir3"(0)|folder|ITEM_CREATE|319542414542|461318fd6e4f93be9f05a8740aeb672e4b1a1e39] added new path ("dir/subdir3") for notify
2025/05/03 02:43:49 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/03 02:43:49 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:43:49 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724975965")
2025/05/03 02:43:49 INFO  : dir/file2.rclone_chunk.001_o56xgt: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/03 02:43:49 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724976193")
2025/05/03 02:43:49 INFO  : dir/file2.rclone_chunk.002_o56xgt: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/03 02:43:50 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724976731")
2025/05/03 02:43:50 DEBUG : box root 'rclone-test-nobumul9kemu': ["subdir2"(0)|folder|ITEM_CREATE|319543026358|8133fb4156dca0b2027c526d82bec597e1d50023] added new path ("dir/subdir2") for notify
2025/05/03 02:43:50 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/03 02:43:50 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:43:50 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724977732")
2025/05/03 02:43:51 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724977959")
2025/05/03 02:43:52 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724978740")
2025/05/03 02:43:52 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2.rclone_chunk.001_o56xgt"(0)|file|ITEM_UPLOAD|1851950572433|fc45bacfabf038af1bd94938cbae8525e07efea6] ignored due to old SequenceID ('\x01')
2025/05/03 02:43:52 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:52 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724979737")
2025/05/03 02:43:53 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724979969")
2025/05/03 02:43:54 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724980733")
2025/05/03 02:43:54 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2.rclone_chunk.002_o56xgt"(0)|file|ITEM_UPLOAD|1851950135519|e6260b96a0538f509677d331ef1f21d8a22518a0] ignored due to old SequenceID ('\x01')
2025/05/03 02:43:54 DEBUG : box root 'rclone-test-nobumul9kemu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:54 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724981728")
2025/05/03 02:43:55 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1851950572433|892850616db8535dc27c08d7474caca6b54d83c1] ignored due to old SequenceID ('\x01')
2025/05/03 02:43:55 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1851950135519|c650249db355c8a4ca09b70a08a5aa447a55dd50] ignored due to old SequenceID ('\x01')
2025/05/03 02:43:55 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:55 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724981968")
2025/05/03 02:43:55 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724982211")
2025/05/03 02:43:56 INFO  : dir/file4.rclone_chunk.001_o575g5: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/03 02:43:56 INFO  : dir/file4.rclone_chunk.002_o575g5: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/03 02:43:56 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724982731")
2025/05/03 02:43:56 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:56 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724983728")
2025/05/03 02:43:57 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724983961")
2025/05/03 02:43:57 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2"(0)|file|ITEM_UPLOAD|1851950363447|0e90baa9ad0dd3b295184620ca4c3721062afa98] ignored due to old SequenceID ('\x00')
2025/05/03 02:43:57 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:57 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724984729")
2025/05/03 02:43:58 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724984961")
2025/05/03 02:43:58 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:58 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724985731")
2025/05/03 02:43:59 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724985962")
2025/05/03 02:43:59 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:43:59 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724986731")
2025/05/03 02:44:00 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724986967")
2025/05/03 02:44:00 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4.rclone_chunk.001_o575g5"(0)|file|ITEM_UPLOAD|1851947560653|caf9bc9bb1a4f95be3fe2457f8da83fe2fceb5d0] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:00 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:00 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724987731")
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4.rclone_chunk.002_o575g5"(0)|file|ITEM_UPLOAD|1851949765742|a33c6b63e56a63f74c71a5f04e3186651fc89ae9] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724987963")
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724988206")
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1851947560653|0c03b3616a93af962187765b85f76593854045b1] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:01 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724988731")
2025/05/03 02:44:02 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1851949765742|1719b931f9b291c5328320252fd726ce60fdbc85] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:02 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:02 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724988968")
2025/05/03 02:44:02 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724989196")
2025/05/03 02:44:02 INFO  : dir/file3.rclone_chunk.001_o57cg4: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/03 02:44:03 INFO  : dir/file3.rclone_chunk.002_o57cg4: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/03 02:44:03 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724989734")
2025/05/03 02:44:03 DEBUG : box root 'rclone-test-nobumul9kemu': ["file1"(0)|file|ITEM_UPLOAD|1851952544681|bb3f8d30fef8d110fdbd86be0d315ad305cd55fa] new parent not found
2025/05/03 02:44:03 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4"(0)|file|ITEM_UPLOAD|1851948769393|2bd0e684459a600b3c36ead49d180ddbe3044a3c] ignored due to old SequenceID ('\x00')
2025/05/03 02:44:03 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:03 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724990731")
2025/05/03 02:44:04 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724990970")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/03 02:44:05 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724991736")
2025/05/03 02:44:05 DEBUG : box root 'rclone-test-nobumul9kemu': ["sub"(0)|folder|ITEM_CREATE|319543110294|128ada494314f7e8cb3414d8894999d48d9724fc] new parent not found
2025/05/03 02:44:05 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:05 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724992736")
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2"(0)|file|ITEM_UPLOAD|1851949485162|f34d6632f457701191f7b02588487571277f5174] new parent not found
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724992974")
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': ["file3.rclone_chunk.001_o57cg4"(0)|file|ITEM_UPLOAD|1851948921226|45e5f548a2821433dbdbae65ea00df0644e2e5d3] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724993203")
2025/05/03 02:44:06 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724993445")
2025/05/03 02:44:07 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724993730")
2025/05/03 02:44:07 DEBUG : box root 'rclone-test-nobumul9kemu': ["file3.rclone_chunk.002_o57cg4"(0)|file|ITEM_UPLOAD|1851949758911|db03959515bc0de446848eb114f4a27f14bbbd1e] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:07 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:07 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724994728")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/03 02:44:08 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724994956")
2025/05/03 02:44:08 DEBUG : box root 'rclone-test-nobumul9kemu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1851949758911|3efde14527eb4b8268c3fc532f16a670fce347af] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:08 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:08 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724995737")
2025/05/03 02:44:09 DEBUG : box root 'rclone-test-nobumul9kemu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1851948921226|5f07d4f3c6af328a72ec52171fa8aea16656d984] ignored due to old SequenceID ('\x01')
2025/05/03 02:44:09 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:09 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724995970")
2025/05/03 02:44:09 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724996207")
2025/05/03 02:44:10 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724996728")
2025/05/03 02:44:10 DEBUG : box root 'rclone-test-nobumul9kemu': ["file3"(0)|file|ITEM_UPLOAD|1851949513926|b29808b3c8c8c2489c0965b468635373476f40cd] ignored due to old SequenceID ('\x00')
2025/05/03 02:44:10 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:10 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724997727")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/03 02:44:11 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724997960")
2025/05/03 02:44:11 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:11 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724998730")
2025/05/03 02:44:12 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724998962")
2025/05/03 02:44:13 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043724999731")
2025/05/03 02:44:13 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:13 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725000729")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/03 02:44:14 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725000967")
2025/05/03 02:44:14 DEBUG : box root 'rclone-test-nobumul9kemu': ["file1"(0)|file|ITEM_UPLOAD|1851952996435|0a86a599f64b56bbf3b94b8bab846adbde9d3d09] new parent not found
2025/05/03 02:44:14 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:14 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725001729")
2025/05/03 02:44:15 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725001955")
2025/05/03 02:44:15 DEBUG : box root 'rclone-test-nobumul9kemu': ["sub"(0)|folder|ITEM_CREATE|319542626232|df6436b0cc6888012fcd83d4eb7e0e85fed769bb] new parent not found
2025/05/03 02:44:15 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:15 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725002726")
2025/05/03 02:44:16 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725002960")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/03 02:44:17 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725003731")
2025/05/03 02:44:17 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2"(0)|file|ITEM_UPLOAD|1851952477912|94044a4fbfadc3cdbeb244e8f40015fa96b506a2] new parent not found
2025/05/03 02:44:17 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:17 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725004746")
2025/05/03 02:44:18 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725004974")
2025/05/03 02:44:19 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725005731")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/03 02:44:20 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725006732")
2025/05/03 02:44:21 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725007730")
2025/05/03 02:44:22 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725008732")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/03 02:44:23 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725009729")
2025/05/03 02:44:24 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725010728")
2025/05/03 02:44:25 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725011734")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/03 02:44:26 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725012729")
2025/05/03 02:44:26 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:26 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725013731")
2025/05/03 02:44:27 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725013957")
2025/05/03 02:44:27 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:27 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725014729")
2025/05/03 02:44:28 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725014963")
2025/05/03 02:44:28 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:28 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725015732")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/03 02:44:29 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725015970")
2025/05/03 02:44:30 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725016729")
2025/05/03 02:44:30 DEBUG : box root 'rclone-test-nobumul9kemu': ["sub dir"(0)|folder|ITEM_CREATE|319543523824|87dffb45d1d10b5ba6a4f6793c2e73341ff3983f] new parent not found
2025/05/03 02:44:30 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:30 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725017733")
2025/05/03 02:44:31 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725017972")
2025/05/03 02:44:31 DEBUG : box root 'rclone-test-nobumul9kemu': ["hello world"(0)|file|ITEM_UPLOAD|1851953162140|83b559ae06fffdb80f39633b2ae26beaba85676b] new parent not found
2025/05/03 02:44:31 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:31 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725018728")
    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/03 02:44:32 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725018960")
2025/05/03 02:44:33 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725019728")
2025/05/03 02:44:34 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725020728")
2025/05/03 02:44:34 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:34 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725021733")
2025/05/03 02:44:35 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725021969")
2025/05/03 02:44:35 DEBUG : box root 'rclone-test-nobumul9kemu': ["potato2"(0)|file|ITEM_UPLOAD|1851952487928|b79a5fee3e2978f36ce14488a44dde3464776e0a] new parent not found
2025/05/03 02:44:35 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:35 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725022728")
2025/05/03 02:44:36 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725022965")
2025/05/03 02:44:37 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725023731")
2025/05/03 02:44:37 DEBUG : box root 'rclone-test-nobumul9kemu': ["empty space"(0)|file|ITEM_UPLOAD|1851954157938|1eb418fb80433b53e243b712a6e755d5b05c2d22] new parent not found
2025/05/03 02:44:37 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:37 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725024731")
2025/05/03 02:44:38 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725024961")
2025/05/03 02:44:39 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725025729")
2025/05/03 02:44:39 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2"(1)|file|ITEM_TRASH|1851950363447|7f405b664af619dda7cf7639158182bebd22e21d] added old path ("dir/file2") for notify
2025/05/03 02:44:39 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:44:39 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:44:39 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725026731")
2025/05/03 02:44:40 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:40 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725026969")
2025/05/03 02:44:40 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725027205")
2025/05/03 02:44:40 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:40 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725027728")
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1851950572433|86fc43209d889def3b9ba787c469f1429f63ba8c] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/03 02:44:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725027958")
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725028195")
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1851950135519|25d40a73a7ed06f8da789952933ffa9a02d4d422] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/03 02:44:41 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:44:41 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725028731")
2025/05/03 02:44:42 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725028960")
2025/05/03 02:44:42 DEBUG : box root 'rclone-test-nobumul9kemu': ["potato2"(0)|file|ITEM_UPLOAD|1851950999354|996c2440caac23ff98bbf76f7516997adeaa31a6] new parent not found
2025/05/03 02:44:42 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4"(1)|file|ITEM_TRASH|1851948769393|e7102a7efa8b83423509ad87c3e0232caf8195b6] added old path ("dir/file4") for notify
2025/05/03 02:44:42 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:44:42 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/03 02:44:42 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725029727")
2025/05/03 02:44:43 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725029962")
2025/05/03 02:44:43 DEBUG : box root 'rclone-test-nobumul9kemu': ["empty space"(0)|file|ITEM_UPLOAD|1851950850368|c40b2da8bfcd105a3e4a4cb9277d6293b4db4720] new parent not found
2025/05/03 02:44:43 DEBUG : box root 'rclone-test-nobumul9kemu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:43 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725030727")
2025/05/03 02:44:44 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725030961")
2025/05/03 02:44:44 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1851947560653|6760b3cfa958824c0285337b39b1828c342b0ab5] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/03 02:44:44 DEBUG : box root 'rclone-test-nobumul9kemu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1851949765742|fe060c8b185dea4e0876d5a6c15335e39cf8f195] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/03 02:44:44 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:44:44 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:44:44 DEBUG : box root 'rclone-test-nobumul9kemu': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/03 02:44:44 DEBUG : box root 'rclone-test-nobumul9kemu': Checking for changes on remote (next_stream_position: "30401043725031730")
2025/05/03 02:44:46 DEBUG : box root 'rclone-test-nobumul9kemu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/03 02:44:46 ERROR : : error listing: directory not found
2025/05/03 02:44:47 DEBUG : box root 'rclone-test-nobumul9kemu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (69.65s)
    --- FAIL: TestIntegration/FsMkdir (67.13s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (65.13s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	69.688s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m12.529742304s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]