"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5) === RUN TestIntegration fstests.go:442: Using remote "TestBox:" 2025/02/14 01:12:07 DEBUG : Creating backend with remote "TestBox:rclone-test-pecihoh6fuve" 2025/02/14 01:12:07 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/14 01:12:08 DEBUG : box root 'rclone-test-pecihoh6fuve': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/02/14 01:12:09 DEBUG : box root 'rclone-test-pecihoh6fuve': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/02/14 01:12:11 INFO : dir: Making directory 2025/02/14 01:12:12 INFO : dir/subdir1: Making directory 2025/02/14 01:12:13 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980279332") 2025/02/14 01:12:13 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-womeken7minu"(0)|folder|ITEM_CREATE|307412142783|1675cc96c0c2d0eba75c6263227fb6a2454b0899] new parent not found 2025/02/14 01:12:13 DEBUG : box root 'rclone-test-pecihoh6fuve': ["new_name"(0)|folder|ITEM_CREATE|307413050275|53aa635a2b884d785d3283031538d1acfa1f5b13] new parent not found 2025/02/14 01:12:13 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 4 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:13 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980280578") 2025/02/14 01:12:13 INFO : dir/subdir3: Making directory 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-womeken7minu"(0)|folder|ITEM_CREATE|307412142783|1675cc96c0c2d0eba75c6263227fb6a2454b0899] ignored due to duplicate EventID 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': ["new_name"(0)|folder|ITEM_CREATE|307413050275|53aa635a2b884d785d3283031538d1acfa1f5b13] ignored due to duplicate EventID 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-topemun7nanu"(1)|folder|ITEM_TRASH|307413836979|4b8b438ef1d97fa22ff43576a349e362bfbfa040] ignored due to duplicate EventID 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980280844") 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-womeken7minu"(0)|folder|ITEM_CREATE|307412142783|1675cc96c0c2d0eba75c6263227fb6a2454b0899] ignored due to duplicate EventID 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': ["new_name"(0)|folder|ITEM_CREATE|307413050275|53aa635a2b884d785d3283031538d1acfa1f5b13] ignored due to duplicate EventID 2025/02/14 01:12:14 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-topemun7nanu"(1)|folder|ITEM_TRASH|307413836979|4b8b438ef1d97fa22ff43576a349e362bfbfa040] ignored due to duplicate EventID 2025/02/14 01:12:15 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980281568") 2025/02/14 01:12:15 INFO : dir/subdir2: Making directory 2025/02/14 01:12:15 DEBUG : box root 'rclone-test-pecihoh6fuve': ["new_name"(0)|folder|ITEM_CREATE|307413050275|53aa635a2b884d785d3283031538d1acfa1f5b13] ignored due to duplicate EventID 2025/02/14 01:12:15 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-topemun7nanu"(1)|folder|ITEM_TRASH|307413836979|4b8b438ef1d97fa22ff43576a349e362bfbfa040] ignored due to duplicate EventID 2025/02/14 01:12:16 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980282576") 2025/02/14 01:12:16 DEBUG : box root 'rclone-test-pecihoh6fuve': ["rclone-test-topemun7nanu"(1)|folder|ITEM_TRASH|307413836979|4b8b438ef1d97fa22ff43576a349e362bfbfa040] ignored due to duplicate EventID 2025/02/14 01:12:16 DEBUG : box root 'rclone-test-pecihoh6fuve': ["file name.txt"(3)|file|ITEM_RENAME|1777281974177|97ba76bf0543eedfcd05097a4de0c58934e44730] new parent not found 2025/02/14 01:12:16 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 2 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:16 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980283581") 2025/02/14 01:12:17 DEBUG : box root 'rclone-test-pecihoh6fuve': ["file name.txt"(3)|file|ITEM_RENAME|1777281974177|97ba76bf0543eedfcd05097a4de0c58934e44730] ignored due to duplicate EventID 2025/02/14 01:12:17 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980283849") 2025/02/14 01:12:17 DEBUG : box root 'rclone-test-pecihoh6fuve': ["file name.txt"(3)|file|ITEM_RENAME|1777281974177|97ba76bf0543eedfcd05097a4de0c58934e44730] ignored due to duplicate EventID 2025/02/14 01:12:18 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980284567") 2025/02/14 01:12:18 DEBUG : box root 'rclone-test-pecihoh6fuve': ["file name.txt"(3)|file|ITEM_RENAME|1777281974177|97ba76bf0543eedfcd05097a4de0c58934e44730] ignored due to duplicate EventID 2025/02/14 01:12:19 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980285563") 2025/02/14 01:12:19 DEBUG : box root 'rclone-test-pecihoh6fuve': ["file name.txt"(3)|file|ITEM_RENAME|1777281974177|97ba76bf0543eedfcd05097a4de0c58934e44730] ignored due to duplicate EventID 2025/02/14 01:12:20 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980286565") 2025/02/14 01:12:20 DEBUG : box root 'rclone-test-pecihoh6fuve': ["file name.txt"(3)|file|ITEM_RENAME|1777281974177|97ba76bf0543eedfcd05097a4de0c58934e44730] ignored due to duplicate EventID 2025/02/14 01:12:21 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980287605") 2025/02/14 01:12:22 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980288560") 2025/02/14 01:12:23 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980289579") fstests.go:935: Try 1/10 waiting for dirChanges and objChanges 2025/02/14 01:12:24 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980290566") 2025/02/14 01:12:25 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980291558") 2025/02/14 01:12:26 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980292563") fstests.go:935: Try 2/10 waiting for dirChanges and objChanges 2025/02/14 01:12:27 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980293567") 2025/02/14 01:12:28 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980294558") 2025/02/14 01:12:29 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980295560") fstests.go:935: Try 3/10 waiting for dirChanges and objChanges 2025/02/14 01:12:30 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980296564") 2025/02/14 01:12:31 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980297560") 2025/02/14 01:12:32 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980298557") fstests.go:935: Try 4/10 waiting for dirChanges and objChanges 2025/02/14 01:12:33 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980299553") 2025/02/14 01:12:34 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980300559") 2025/02/14 01:12:35 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980301558") fstests.go:935: Try 5/10 waiting for dirChanges and objChanges 2025/02/14 01:12:36 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980302558") 2025/02/14 01:12:37 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980303559") 2025/02/14 01:12:38 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980304560") fstests.go:935: Try 6/10 waiting for dirChanges and objChanges 2025/02/14 01:12:39 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980305574") 2025/02/14 01:12:40 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980306559") 2025/02/14 01:12:41 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980307559") fstests.go:935: Try 7/10 waiting for dirChanges and objChanges 2025/02/14 01:12:42 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980308562") 2025/02/14 01:12:43 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980309582") 2025/02/14 01:12:44 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980310569") fstests.go:935: Try 8/10 waiting for dirChanges and objChanges 2025/02/14 01:12:44 DEBUG : box root 'rclone-test-pecihoh6fuve': ["somefile"(0)|file|ITEM_UPLOAD|1777280627262|53f7b080a79921a4acce4a4522bc96d5f31baaf3] new parent not found 2025/02/14 01:12:44 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 1 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:44 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980311587") 2025/02/14 01:12:45 DEBUG : box root 'rclone-test-pecihoh6fuve': ["somefile"(0)|file|ITEM_UPLOAD|1777280627262|53f7b080a79921a4acce4a4522bc96d5f31baaf3] ignored due to duplicate EventID 2025/02/14 01:12:45 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980311835") 2025/02/14 01:12:45 DEBUG : box root 'rclone-test-pecihoh6fuve': ["somefile"(0)|file|ITEM_UPLOAD|1777280627262|53f7b080a79921a4acce4a4522bc96d5f31baaf3] ignored due to duplicate EventID 2025/02/14 01:12:46 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980312581") 2025/02/14 01:12:46 DEBUG : box root 'rclone-test-pecihoh6fuve': ["somefile"(0)|file|ITEM_UPLOAD|1777280627262|53f7b080a79921a4acce4a4522bc96d5f31baaf3] ignored due to duplicate EventID 2025/02/14 01:12:47 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980313579") fstests.go:935: Try 9/10 waiting for dirChanges and objChanges 2025/02/14 01:12:47 DEBUG : box root 'rclone-test-pecihoh6fuve': ["somefile"(0)|file|ITEM_UPLOAD|1777280627262|53f7b080a79921a4acce4a4522bc96d5f31baaf3] ignored due to duplicate EventID 2025/02/14 01:12:48 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980314585") 2025/02/14 01:12:48 DEBUG : box root 'rclone-test-pecihoh6fuve': ["somefile"(0)|file|ITEM_UPLOAD|1777280627262|53f7b080a79921a4acce4a4522bc96d5f31baaf3] ignored due to duplicate EventID 2025/02/14 01:12:49 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980315565") 2025/02/14 01:12:49 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 1 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:49 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980316577") 2025/02/14 01:12:50 DEBUG : box root 'rclone-test-pecihoh6fuve': ["Hello, 世界"(1)|folder|ITEM_TRASH|307409015505|5540178bb7942a92969c5043ee65e3d9f8da4e3b] ignored due to duplicate EventID 2025/02/14 01:12:50 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980316834") fstests.go:939: map[] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[] does not contain [dir/file2 dir/file4 dir/file3] 2025/02/14 01:12:50 DEBUG : box root 'rclone-test-pecihoh6fuve': ["Hello, 世界"(1)|folder|ITEM_TRASH|307409015505|5540178bb7942a92969c5043ee65e3d9f8da4e3b] ignored due to duplicate EventID 2025/02/14 01:12:51 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980317592") 2025/02/14 01:12:51 DEBUG : box root 'rclone-test-pecihoh6fuve': ["Hello, 世界"(1)|folder|ITEM_TRASH|307409015505|5540178bb7942a92969c5043ee65e3d9f8da4e3b] ignored due to duplicate EventID 2025/02/14 01:12:52 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980318572") 2025/02/14 01:12:52 DEBUG : box root 'rclone-test-pecihoh6fuve': ["Hello, 世界"(1)|folder|ITEM_TRASH|307409015505|5540178bb7942a92969c5043ee65e3d9f8da4e3b] ignored due to duplicate EventID 2025/02/14 01:12:53 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980319595") 2025/02/14 01:12:53 DEBUG : box root 'rclone-test-pecihoh6fuve': ["Hello, 世界"(1)|folder|ITEM_TRASH|307409015505|5540178bb7942a92969c5043ee65e3d9f8da4e3b] ignored due to duplicate EventID 2025/02/14 01:12:54 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980320587") 2025/02/14 01:12:55 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980321598") 2025/02/14 01:12:55 DEBUG : box root 'rclone-test-pecihoh6fuve': ["piped data.txt"(0)|file|ITEM_UPLOAD|1777279163727|a74c58fc6f7470e37f1da326404798c311da2121] new parent not found 2025/02/14 01:12:55 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 1 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:55 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980322583") 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': ["piped data.txt"(0)|file|ITEM_UPLOAD|1777279163727|a74c58fc6f7470e37f1da326404798c311da2121] ignored due to duplicate EventID 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 2 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980322869") 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': ["piped data.txt"(0)|file|ITEM_UPLOAD|1777279163727|a74c58fc6f7470e37f1da326404798c311da2121] ignored due to duplicate EventID 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': ["hello? sausage"(1)|folder|ITEM_TRASH|307412507784|020429b459ebf624275a9ecf21c61a90d9cb81d9] ignored due to duplicate EventID 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980323134") 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': ["piped data.txt"(0)|file|ITEM_UPLOAD|1777279163727|a74c58fc6f7470e37f1da326404798c311da2121] ignored due to duplicate EventID 2025/02/14 01:12:56 DEBUG : box root 'rclone-test-pecihoh6fuve': ["hello? sausage"(1)|folder|ITEM_TRASH|307412507784|020429b459ebf624275a9ecf21c61a90d9cb81d9] ignored due to duplicate EventID 2025/02/14 01:12:57 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980323595") 2025/02/14 01:12:57 DEBUG : box root 'rclone-test-pecihoh6fuve': ["piped data.txt"(0)|file|ITEM_UPLOAD|1777279163727|a74c58fc6f7470e37f1da326404798c311da2121] ignored due to duplicate EventID 2025/02/14 01:12:57 DEBUG : box root 'rclone-test-pecihoh6fuve': ["hello? sausage"(1)|folder|ITEM_TRASH|307412507784|020429b459ebf624275a9ecf21c61a90d9cb81d9] ignored due to duplicate EventID 2025/02/14 01:12:57 DEBUG : box root 'rclone-test-pecihoh6fuve': ["created from root.txt"(0)|file|ITEM_UPLOAD|1777280943803|29509071026ea7bb16476c2b50364e8e2a1aeac9] new parent not found 2025/02/14 01:12:57 DEBUG : box root 'rclone-test-pecihoh6fuve': Received 3 events, resulting in 0 paths and 0 notifications 2025/02/14 01:12:57 DEBUG : box root 'rclone-test-pecihoh6fuve': Checking for changes on remote (next_stream_position: "30401036980324606") 2025/02/14 01:12:58 DEBUG : box root 'rclone-test-pecihoh6fuve': ["piped data.txt"(0)|file|ITEM_UPLOAD|1777279163727|a74c58fc6f7470e37f1da326404798c311da2121] ignored due to duplicate EventID 2025/02/14 01:12:58 DEBUG : box root 'rclone-test-pecihoh6fuve': ["hello? sausage"(1)|folder|ITEM_TRASH|307412507784|020429b459ebf624275a9ecf21c61a90d9cb81d9] ignored due to duplicate EventID 2025/02/14 01:12:58 DEBUG : box root 'rclone-test-pecihoh6fuve': ["created from root.txt"(0)|file|ITEM_UPLOAD|1777280943803|29509071026ea7bb16476c2b50364e8e2a1aeac9] ignored due to duplicate EventID 2025/02/14 01:12:59 DEBUG : box root 'rclone-test-pecihoh6fuve': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/02/14 01:12:59 ERROR : : error listing: directory not found 2025/02/14 01:13:00 DEBUG : box root 'rclone-test-pecihoh6fuve': Ignoring "Shared folder — ForNick" - unknown type "web_link" --- FAIL: TestIntegration (52.81s) --- FAIL: TestIntegration/FsMkdir (49.65s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (46.90s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/box 52.818s "go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 53.295920973s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]