"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/05 03:02:23 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-viyicul0fohu"
2025/03/05 03:02:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/05 03:02:23 DEBUG : Creating backend with remote "TestBox:rclone-test-viyicul0fohu"
2025/03/05 03:02:24 DEBUG : box root 'rclone-test-viyicul0fohu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/05 03:02:24 DEBUG : Reset feature "ListR"
2025/03/05 03:02:25 DEBUG : box root 'rclone-test-viyicul0fohu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/05 03:02:26 INFO  : dir: Making directory
2025/03/05 03:02:27 INFO  : dir/subdir1: Making directory
2025/03/05 03:02:28 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628494517")
2025/03/05 03:02:28 INFO  : dir/subdir3: Making directory
2025/03/05 03:02:29 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628495739")
2025/03/05 03:02:29 INFO  : dir/subdir2: Making directory
2025/03/05 03:02:30 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628496747")
2025/03/05 03:02:31 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628497739")
2025/03/05 03:02:32 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628498745")
2025/03/05 03:02:33 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628499738")
2025/03/05 03:02:34 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628500742")
2025/03/05 03:02:35 INFO  : dir/file2.rclone_chunk.001_mwpnqu: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/05 03:02:35 INFO  : dir/file2.rclone_chunk.002_mwpnqu: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/05 03:02:35 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628501743")
2025/03/05 03:02:36 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628502736")
2025/03/05 03:02:37 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628503737")
2025/03/05 03:02:38 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628504743")
2025/03/05 03:02:39 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628505737")
2025/03/05 03:02:40 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628506742")
2025/03/05 03:02:41 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628507751")
2025/03/05 03:02:42 INFO  : dir/file4.rclone_chunk.001_mwpuid: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/05 03:02:42 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628508762")
2025/03/05 03:02:43 INFO  : dir/file4.rclone_chunk.002_mwpuid: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/05 03:02:43 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628509752")
2025/03/05 03:02:44 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628510745")
2025/03/05 03:02:45 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628511739")
2025/03/05 03:02:46 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628512759")
2025/03/05 03:02:47 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628513763")
2025/03/05 03:02:48 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628514759")
2025/03/05 03:02:49 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628515758")
2025/03/05 03:02:50 DEBUG : box root 'rclone-test-viyicul0fohu': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/05 03:02:50 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628516785")
2025/03/05 03:02:50 INFO  : dir/file3.rclone_chunk.001_mwq213: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/05 03:02:51 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628517923")
2025/03/05 03:02:51 INFO  : dir/file3.rclone_chunk.002_mwq213: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/05 03:02:51 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628518193")
2025/03/05 03:02:52 DEBUG : box root 'rclone-test-viyicul0fohu': ["ignore_checksum_big_file_from_pipe.rclone_chunk.007"(2)|file|ITEM_TRASH|1793989101358|636d1ef741cb56564af84f7c4f5d04223a42c3a2] ignored due to duplicate EventID
2025/03/05 03:02:52 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628518777")
2025/03/05 03:02:53 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628519807")
2025/03/05 03:02:54 DEBUG : box root 'rclone-test-viyicul0fohu': ["ignore_checksum_big_file_from_pipe.rclone_chunk.007"(2)|file|ITEM_TRASH|1793989101358|636d1ef741cb56564af84f7c4f5d04223a42c3a2] ignored due to duplicate EventID
2025/03/05 03:02:54 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628520778")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/05 03:02:55 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628521776")
2025/03/05 03:02:56 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628522801")
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': ["HELLO, WORLD!"(1)|file|ITEM_RENAME|1793976095240|77fae4bb434105baf132a73add0c3a70f1b7fe5f] new parent not found
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628523763")
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': ["HELLO, WORLD!"(1)|file|ITEM_RENAME|1793976095240|77fae4bb434105baf132a73add0c3a70f1b7fe5f] ignored due to duplicate EventID
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628524118")
2025/03/05 03:02:57 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628524403")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/05 03:02:58 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628524782")
2025/03/05 03:02:59 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628525824")
2025/03/05 03:03:00 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628526787")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/05 03:03:01 DEBUG : box root 'rclone-test-viyicul0fohu': ["HELLO, WORLD!"(1)|file|ITEM_RENAME|1793976095240|77fae4bb434105baf132a73add0c3a70f1b7fe5f] ignored due to duplicate EventID
2025/03/05 03:03:01 DEBUG : box root 'rclone-test-viyicul0fohu': ["dir"(1)|folder|ITEM_TRASH|310177448492|b089055fdc875588b747e4cc15ab0249c2807c4f] ignored due to duplicate EventID
2025/03/05 03:03:01 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628528003")
2025/03/05 03:03:02 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628528933")
2025/03/05 03:03:03 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628529781")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/05 03:03:04 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628530789")
2025/03/05 03:03:05 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628531752")
2025/03/05 03:03:06 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628532767")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/05 03:03:07 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628533754")
2025/03/05 03:03:08 DEBUG : box root 'rclone-test-viyicul0fohu': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/05 03:03:08 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628535023")
2025/03/05 03:03:08 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628535364")
2025/03/05 03:03:09 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628535755")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/05 03:03:10 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628536747")
2025/03/05 03:03:11 DEBUG : box root 'rclone-test-viyicul0fohu': ["piped data.txt.rclone_chunk.003"(2)|file|ITEM_TRASH|1793996200299|c5e7c83e6ef8925955e81401e97b1291c569d652] ignored due to duplicate EventID
2025/03/05 03:03:11 DEBUG : box root 'rclone-test-viyicul0fohu': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/05 03:03:11 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628537752")
2025/03/05 03:03:11 DEBUG : box root 'rclone-test-viyicul0fohu': ["piped data.txt.rclone_chunk.003"(2)|file|ITEM_TRASH|1793996200299|c5e7c83e6ef8925955e81401e97b1291c569d652] ignored due to duplicate EventID
2025/03/05 03:03:11 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628538023")
2025/03/05 03:03:12 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628538745")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/05 03:03:13 DEBUG : box root 'rclone-test-viyicul0fohu': ["potato2.rclone_chunk.002"(2)|file|ITEM_TRASH|1793993570138|9e42c798ba557942890c405924eae05809dc5a34] ignored due to duplicate EventID
2025/03/05 03:03:13 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628539760")
2025/03/05 03:03:14 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628540757")
2025/03/05 03:03:15 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628541747")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/05 03:03:16 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628542751")
2025/03/05 03:03:17 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628543804")
2025/03/05 03:03:18 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628544753")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/05 03:03:19 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628545739")
2025/03/05 03:03:20 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628547256")
2025/03/05 03:03:21 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628547747")
    fstests.go:935: map[] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/05 03:03:22 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628548747")
2025/03/05 03:03:23 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628549761")
2025/03/05 03:03:24 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628550741")
2025/03/05 03:03:25 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628551745")
2025/03/05 03:03:26 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628552749")
2025/03/05 03:03:27 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628553738")
2025/03/05 03:03:28 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628554743")
2025/03/05 03:03:29 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628555742")
2025/03/05 03:03:30 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628556738")
2025/03/05 03:03:31 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628557743")
2025/03/05 03:03:32 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628558738")
2025/03/05 03:03:33 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628559740")
2025/03/05 03:03:34 DEBUG : box root 'rclone-test-viyicul0fohu': Checking for changes on remote (next_stream_position: "30401038628560747")
2025/03/05 03:03:36 DEBUG : box root 'rclone-test-viyicul0fohu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/05 03:03:36 ERROR : : error listing: directory not found
2025/03/05 03:03:37 DEBUG : box root 'rclone-test-viyicul0fohu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (73.27s)
    --- FAIL: TestIntegration/FsMkdir (70.99s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (68.95s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	73.301s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m15.320693599s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]