"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 4/5) === RUN TestIntegration fstests.go:438: Using remote "TestBox:" 2025/03/06 07:16:52 DEBUG : Creating backend with remote "TestBox:rclone-test-hixuqob3boxu" 2025/03/06 07:16:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/06 07:16:53 DEBUG : box root 'rclone-test-hixuqob3boxu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/06 07:16:54 DEBUG : box root 'rclone-test-hixuqob3boxu': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/03/06 07:16:55 INFO : dir: Making directory 2025/03/06 07:16:57 INFO : dir/subdir1: Making directory 2025/03/06 07:16:58 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730164064") 2025/03/06 07:16:58 INFO : dir/subdir3: Making directory 2025/03/06 07:16:58 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(0)|file|ITEM_UPLOAD|1795267540138|5b210d422cd06f473420e02c775e7a81df940f61] new parent not found 2025/03/06 07:16:58 DEBUG : box root 'rclone-test-hixuqob3boxu': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/06 07:16:58 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730165308") 2025/03/06 07:16:59 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730165559") 2025/03/06 07:16:59 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(0)|file|ITEM_UPLOAD|1795267540138|5b210d422cd06f473420e02c775e7a81df940f61] ignored due to duplicate EventID 2025/03/06 07:16:59 INFO : dir/subdir2: Making directory 2025/03/06 07:17:00 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730166311") 2025/03/06 07:17:00 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(0)|file|ITEM_UPLOAD|1795267540138|5b210d422cd06f473420e02c775e7a81df940f61] ignored due to duplicate EventID 2025/03/06 07:17:01 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730167593") 2025/03/06 07:17:02 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730168384") 2025/03/06 07:17:03 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730169352") 2025/03/06 07:17:03 DEBUG : box root 'rclone-test-hixuqob3boxu': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/06 07:17:03 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730170304") 2025/03/06 07:17:03 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file2"(1)|file|ITEM_TRASH|1795266114399|ebe1106b2908a5d5abee35c7f0488aa30f0de949] ignored due to duplicate EventID 2025/03/06 07:17:03 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(1)|file|ITEM_TRASH|1795267540138|beb9c764c6f8bc39c6253a95596c7f6f75e89300] ignored due to duplicate EventID 2025/03/06 07:17:04 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730170598") 2025/03/06 07:17:04 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file2"(1)|file|ITEM_TRASH|1795266114399|ebe1106b2908a5d5abee35c7f0488aa30f0de949] ignored due to duplicate EventID 2025/03/06 07:17:04 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(1)|file|ITEM_TRASH|1795267540138|beb9c764c6f8bc39c6253a95596c7f6f75e89300] ignored due to duplicate EventID 2025/03/06 07:17:05 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730171306") 2025/03/06 07:17:06 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730172318") 2025/03/06 07:17:06 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file2"(1)|file|ITEM_TRASH|1795266114399|ebe1106b2908a5d5abee35c7f0488aa30f0de949] ignored due to duplicate EventID 2025/03/06 07:17:06 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(1)|file|ITEM_TRASH|1795267540138|beb9c764c6f8bc39c6253a95596c7f6f75e89300] ignored due to duplicate EventID 2025/03/06 07:17:07 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730173338") 2025/03/06 07:17:07 DEBUG : box root 'rclone-test-hixuqob3boxu': ["file4"(1)|file|ITEM_TRASH|1795267540138|beb9c764c6f8bc39c6253a95596c7f6f75e89300] ignored due to duplicate EventID 2025/03/06 07:17:08 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730174316") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/06 07:17:09 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730175346") 2025/03/06 07:17:10 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730176312") 2025/03/06 07:17:11 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730177324") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/06 07:17:12 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730178313") 2025/03/06 07:17:13 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730179309") 2025/03/06 07:17:14 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730180295") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/06 07:17:14 DEBUG : box root 'rclone-test-hixuqob3boxu': Received 3 events, resulting in 0 paths and 0 notifications 2025/03/06 07:17:14 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730181317") 2025/03/06 07:17:15 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730181595") 2025/03/06 07:17:15 DEBUG : box root 'rclone-test-hixuqob3boxu': ["rclone-test-yutuqed9luti"(1)|folder|ITEM_TRASH|310386860849|ca6f8e6c176ae5d20c0983e1ed941a777f71fa97] ignored due to duplicate EventID 2025/03/06 07:17:16 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730182303") 2025/03/06 07:17:17 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730183300") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/06 07:17:18 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730184308") 2025/03/06 07:17:18 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir2"(0)|folder|ITEM_CREATE|310388308352|f7c4abc3e4cbfbe41d0086dcc1d452ff1c468fd7] added new path ("dir/subdir2") for notify 2025/03/06 07:17:18 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/03/06 07:17:18 DEBUG : box root 'rclone-test-hixuqob3boxu': Received 2 events, resulting in 1 paths and 1 notifications 2025/03/06 07:17:18 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730185299") 2025/03/06 07:17:19 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730185535") 2025/03/06 07:17:20 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730186320") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/06 07:17:20 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir1"(1)|folder|ITEM_TRASH|310389352295|9d977a5437a9de6de0b32c0f65f961e7ce73510f] ignored due to duplicate EventID 2025/03/06 07:17:20 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir2"(0)|folder|ITEM_CREATE|310388308352|f7c4abc3e4cbfbe41d0086dcc1d452ff1c468fd7] ignored due to duplicate EventID 2025/03/06 07:17:20 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir3"(0)|folder|ITEM_CREATE|310390052461|69aca05fb60f0f4c67900e170d42a6f12539a6fa] added new path ("dir/subdir3") for notify 2025/03/06 07:17:20 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/03/06 07:17:20 DEBUG : box root 'rclone-test-hixuqob3boxu': Received 3 events, resulting in 1 paths and 1 notifications 2025/03/06 07:17:20 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730187289") 2025/03/06 07:17:21 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730187544") 2025/03/06 07:17:22 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730188299") 2025/03/06 07:17:22 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir1"(1)|folder|ITEM_TRASH|310389352295|9d977a5437a9de6de0b32c0f65f961e7ce73510f] ignored due to duplicate EventID 2025/03/06 07:17:22 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir2"(0)|folder|ITEM_CREATE|310388308352|f7c4abc3e4cbfbe41d0086dcc1d452ff1c468fd7] ignored due to duplicate EventID 2025/03/06 07:17:23 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730189293") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/06 07:17:24 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730190313") 2025/03/06 07:17:24 DEBUG : box root 'rclone-test-hixuqob3boxu': ["subdir3"(0)|folder|ITEM_CREATE|310390052461|69aca05fb60f0f4c67900e170d42a6f12539a6fa] ignored due to duplicate EventID 2025/03/06 07:17:25 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730191291") 2025/03/06 07:17:25 DEBUG : box root 'rclone-test-hixuqob3boxu': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/06 07:17:25 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730192290") 2025/03/06 07:17:26 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730192514") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/06 07:17:26 DEBUG : box root 'rclone-test-hixuqob3boxu': ["dir"(1)|folder|ITEM_TRASH|310385802589|89a857fab06599dc865ce375c678a38851df7622] ignored due to duplicate EventID 2025/03/06 07:17:27 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730193296") 2025/03/06 07:17:28 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730194304") 2025/03/06 07:17:29 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730195285") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/06 07:17:30 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730196284") 2025/03/06 07:17:31 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730197284") 2025/03/06 07:17:32 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730198285") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/06 07:17:33 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730199284") 2025/03/06 07:17:34 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730200300") 2025/03/06 07:17:35 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730201284") fstests.go:935: map[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/03/06 07:17:36 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730202285") 2025/03/06 07:17:37 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730203285") 2025/03/06 07:17:38 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730204285") 2025/03/06 07:17:39 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730205282") 2025/03/06 07:17:40 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730206289") 2025/03/06 07:17:41 DEBUG : box root 'rclone-test-hixuqob3boxu': Checking for changes on remote (next_stream_position: "30401038730207287") 2025/03/06 07:17:42 DEBUG : box root 'rclone-test-hixuqob3boxu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/06 07:17:42 ERROR : : error listing: directory not found 2025/03/06 07:17:43 DEBUG : box root 'rclone-test-hixuqob3boxu': Ignoring "Shared folder — ForNick" - unknown type "web_link" --- FAIL: TestIntegration (51.13s) --- FAIL: TestIntegration/FsMkdir (48.25s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (45.75s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/box 51.145s "go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 51.69613801s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]