"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 4/5)
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestBox:"
2025/02/19 04:51:39 DEBUG : Creating backend with remote "TestBox:rclone-test-zoyupoc9decu"
2025/02/19 04:51:39 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/02/19 04:51:40 DEBUG : box root 'rclone-test-zoyupoc9decu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/02/19 04:51:41 DEBUG : box root 'rclone-test-zoyupoc9decu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/02/19 04:51:42 INFO  : dir: Making directory
2025/02/19 04:51:45 INFO  : dir/subdir1: Making directory
2025/02/19 04:51:46 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425452580")
2025/02/19 04:51:47 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file4"(0)|file|ITEM_UPLOAD|1781686818634|f0ba01bcd4479a9de5533810923055e2b4c8bc04] new parent not found
2025/02/19 04:51:47 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 2 events, resulting in 0 paths and 0 notifications
2025/02/19 04:51:47 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425453839")
2025/02/19 04:51:47 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file4"(0)|file|ITEM_UPLOAD|1781686818634|f0ba01bcd4479a9de5533810923055e2b4c8bc04] ignored due to duplicate EventID
2025/02/19 04:51:47 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-letuqeb0sale"(1)|folder|ITEM_TRASH|308124049288|642e198e13f2c2b4d32fe4cd4ecaa3f52f68e0f7] ignored due to duplicate EventID
2025/02/19 04:51:47 INFO  : dir/subdir3: Making directory
2025/02/19 04:51:47 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425454069")
2025/02/19 04:51:48 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file4"(0)|file|ITEM_UPLOAD|1781686818634|f0ba01bcd4479a9de5533810923055e2b4c8bc04] ignored due to duplicate EventID
2025/02/19 04:51:48 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-letuqeb0sale"(1)|folder|ITEM_TRASH|308124049288|642e198e13f2c2b4d32fe4cd4ecaa3f52f68e0f7] ignored due to duplicate EventID
2025/02/19 04:51:48 INFO  : dir/subdir2: Making directory
2025/02/19 04:51:48 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425454821")
2025/02/19 04:51:49 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-letuqeb0sale"(1)|folder|ITEM_TRASH|308124049288|642e198e13f2c2b4d32fe4cd4ecaa3f52f68e0f7] ignored due to duplicate EventID
2025/02/19 04:51:49 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425455884")
2025/02/19 04:51:50 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-letuqeb0sale"(1)|folder|ITEM_TRASH|308124049288|642e198e13f2c2b4d32fe4cd4ecaa3f52f68e0f7] ignored due to duplicate EventID
2025/02/19 04:51:50 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425456829")
2025/02/19 04:51:51 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425457846")
2025/02/19 04:51:52 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425458866")
2025/02/19 04:51:53 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425459835")
2025/02/19 04:51:54 DEBUG : Couldn't decode error response: invalid character 'u' looking for beginning of value
2025/02/19 04:51:54 DEBUG : pacer: low level retry 1/10 (error Error "503 Service Unavailable" (503))
2025/02/19 04:51:54 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2025/02/19 04:51:54 DEBUG : pacer: Reducing sleep to 15ms
2025/02/19 04:51:54 DEBUG : pacer: Reducing sleep to 11.25ms
2025/02/19 04:51:54 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 1 events, resulting in 0 paths and 0 notifications
2025/02/19 04:51:54 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425461258")
2025/02/19 04:51:54 DEBUG : pacer: Reducing sleep to 10ms
2025/02/19 04:51:54 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(1)|folder|ITEM_TRASH|308124673878|2a6c7826d7c47fb652cee563c2bc4740f554e837] ignored due to duplicate EventID
2025/02/19 04:51:54 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-zoyupoc9decu"(0)|folder|ITEM_CREATE|308125211216|5e2152078c1b77d3df06e8dd7ee8da00757d332d] new parent not found
2025/02/19 04:51:54 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 2 events, resulting in 0 paths and 0 notifications
2025/02/19 04:51:54 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425461504")
2025/02/19 04:51:55 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(1)|folder|ITEM_TRASH|308124673878|2a6c7826d7c47fb652cee563c2bc4740f554e837] ignored due to duplicate EventID
2025/02/19 04:51:55 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-zoyupoc9decu"(0)|folder|ITEM_CREATE|308125211216|5e2152078c1b77d3df06e8dd7ee8da00757d332d] ignored due to duplicate EventID
2025/02/19 04:51:55 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425461795")
2025/02/19 04:51:55 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425462053")
2025/02/19 04:51:56 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(1)|folder|ITEM_TRASH|308124673878|2a6c7826d7c47fb652cee563c2bc4740f554e837] ignored due to duplicate EventID
2025/02/19 04:51:56 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-zoyupoc9decu"(0)|folder|ITEM_CREATE|308125211216|5e2152078c1b77d3df06e8dd7ee8da00757d332d] ignored due to duplicate EventID
2025/02/19 04:51:56 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425462830")
2025/02/19 04:51:57 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(1)|folder|ITEM_TRASH|308124673878|2a6c7826d7c47fb652cee563c2bc4740f554e837] ignored due to duplicate EventID
2025/02/19 04:51:57 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-zoyupoc9decu"(0)|folder|ITEM_CREATE|308125211216|5e2152078c1b77d3df06e8dd7ee8da00757d332d] ignored due to duplicate EventID
    fstests.go:935: Try 1/10 waiting for dirChanges and objChanges
2025/02/19 04:51:57 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425463823")
2025/02/19 04:51:58 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425464863")
2025/02/19 04:51:59 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(1)|folder|ITEM_TRASH|308124673878|2a6c7826d7c47fb652cee563c2bc4740f554e837] ignored due to duplicate EventID
2025/02/19 04:51:59 DEBUG : box root 'rclone-test-zoyupoc9decu': ["rclone-test-zoyupoc9decu"(0)|folder|ITEM_CREATE|308125211216|5e2152078c1b77d3df06e8dd7ee8da00757d332d] ignored due to duplicate EventID
2025/02/19 04:51:59 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425465830")
2025/02/19 04:52:00 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 2 events, resulting in 0 paths and 0 notifications
2025/02/19 04:52:00 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425466826")
    fstests.go:935: Try 2/10 waiting for dirChanges and objChanges
2025/02/19 04:52:00 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425467146")
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir2"(1)|folder|ITEM_TRASH|308123982270|96a6e7f797bc16057b2987603d77c56d1edc29af] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(1)|file|ITEM_TRASH|1781694787180|d8229b7e73abaf6c0d9601f0f0bf6951b776abb8] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(0)|folder|ITEM_CREATE|308125490055|d730e2f67ca663bc2e5aecb6d6231b3536c918cd] added new path ("dir") for notify
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781698688557|cf38cb2f0a736672a4cc8bf2b7c918c258d9f570] added new path ("dir/file3") for notify
2025/02/19 04:52:01 DEBUG : doChangeNotify("dir", 0)
2025/02/19 04:52:01 DEBUG : doChangeNotify("dir/file3", 1)
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 5 events, resulting in 2 paths and 2 notifications
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425467831")
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir2"(1)|folder|ITEM_TRASH|308123982270|96a6e7f797bc16057b2987603d77c56d1edc29af] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(1)|file|ITEM_TRASH|1781694787180|d8229b7e73abaf6c0d9601f0f0bf6951b776abb8] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(1)|folder|ITEM_TRASH|308124152866|3493bcd8be088e43b63f7ebd2aaf1024f03318db] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(0)|folder|ITEM_CREATE|308125490055|d730e2f67ca663bc2e5aecb6d6231b3536c918cd] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781698688557|cf38cb2f0a736672a4cc8bf2b7c918c258d9f570] ignored due to duplicate EventID
2025/02/19 04:52:01 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425468142")
2025/02/19 04:52:02 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir2"(1)|folder|ITEM_TRASH|308123982270|96a6e7f797bc16057b2987603d77c56d1edc29af] ignored due to duplicate EventID
2025/02/19 04:52:02 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(1)|file|ITEM_TRASH|1781694787180|d8229b7e73abaf6c0d9601f0f0bf6951b776abb8] ignored due to duplicate EventID
2025/02/19 04:52:02 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(1)|folder|ITEM_TRASH|308124152866|3493bcd8be088e43b63f7ebd2aaf1024f03318db] ignored due to duplicate EventID
2025/02/19 04:52:02 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(0)|folder|ITEM_CREATE|308125490055|d730e2f67ca663bc2e5aecb6d6231b3536c918cd] ignored due to duplicate EventID
2025/02/19 04:52:02 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781698688557|cf38cb2f0a736672a4cc8bf2b7c918c258d9f570] ignored due to duplicate EventID
2025/02/19 04:52:02 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425468854")
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir2"(1)|folder|ITEM_TRASH|308123982270|96a6e7f797bc16057b2987603d77c56d1edc29af] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(1)|file|ITEM_TRASH|1781694787180|d8229b7e73abaf6c0d9601f0f0bf6951b776abb8] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(1)|folder|ITEM_TRASH|308124152866|3493bcd8be088e43b63f7ebd2aaf1024f03318db] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(0)|folder|ITEM_CREATE|308125490055|d730e2f67ca663bc2e5aecb6d6231b3536c918cd] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781698688557|cf38cb2f0a736672a4cc8bf2b7c918c258d9f570] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 6 events, resulting in 0 paths and 0 notifications
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425469825")
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir2"(1)|folder|ITEM_TRASH|308123982270|96a6e7f797bc16057b2987603d77c56d1edc29af] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(1)|file|ITEM_TRASH|1781694787180|d8229b7e73abaf6c0d9601f0f0bf6951b776abb8] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(1)|folder|ITEM_TRASH|308124152866|3493bcd8be088e43b63f7ebd2aaf1024f03318db] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(0)|folder|ITEM_CREATE|308125490055|d730e2f67ca663bc2e5aecb6d6231b3536c918cd] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781698688557|cf38cb2f0a736672a4cc8bf2b7c918c258d9f570] ignored due to duplicate EventID
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file4"(1)|file|ITEM_TRASH|1781686818634|ad265a6551e9fd9ae9f5d5867d88d2ad9eae4d25] ignored due to duplicate EventID
    fstests.go:935: Try 3/10 waiting for dirChanges and objChanges
2025/02/19 04:52:03 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425470114")
2025/02/19 04:52:04 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(1)|file|ITEM_TRASH|1781694787180|d8229b7e73abaf6c0d9601f0f0bf6951b776abb8] ignored due to duplicate EventID
2025/02/19 04:52:04 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425470838")
2025/02/19 04:52:05 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(1)|folder|ITEM_TRASH|308124152866|3493bcd8be088e43b63f7ebd2aaf1024f03318db] ignored due to duplicate EventID
2025/02/19 04:52:05 DEBUG : box root 'rclone-test-zoyupoc9decu': ["dir"(0)|folder|ITEM_CREATE|308125490055|d730e2f67ca663bc2e5aecb6d6231b3536c918cd] ignored due to duplicate EventID
2025/02/19 04:52:05 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781698688557|cf38cb2f0a736672a4cc8bf2b7c918c258d9f570] ignored due to duplicate EventID
2025/02/19 04:52:05 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file4"(1)|file|ITEM_TRASH|1781686818634|ad265a6551e9fd9ae9f5d5867d88d2ad9eae4d25] ignored due to duplicate EventID
2025/02/19 04:52:05 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425471816")
    fstests.go:935: Try 4/10 waiting for dirChanges and objChanges
2025/02/19 04:52:06 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425472818")
2025/02/19 04:52:07 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file4"(1)|file|ITEM_TRASH|1781686818634|ad265a6551e9fd9ae9f5d5867d88d2ad9eae4d25] ignored due to duplicate EventID
2025/02/19 04:52:07 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781694787180|d74a95a42bedeb5890b5fb6da1007502434f74fd] new parent not found
2025/02/19 04:52:07 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 2 events, resulting in 0 paths and 0 notifications
2025/02/19 04:52:07 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425473809")
2025/02/19 04:52:07 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781694787180|d74a95a42bedeb5890b5fb6da1007502434f74fd] ignored due to duplicate EventID
2025/02/19 04:52:07 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425474058")
2025/02/19 04:52:08 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781694787180|d74a95a42bedeb5890b5fb6da1007502434f74fd] ignored due to duplicate EventID
2025/02/19 04:52:08 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425474832")
2025/02/19 04:52:09 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781694787180|d74a95a42bedeb5890b5fb6da1007502434f74fd] ignored due to duplicate EventID
2025/02/19 04:52:09 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 2 events, resulting in 0 paths and 0 notifications
2025/02/19 04:52:09 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425475810")
    fstests.go:935: Try 5/10 waiting for dirChanges and objChanges
2025/02/19 04:52:09 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425476069")
2025/02/19 04:52:10 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425476824")
2025/02/19 04:52:11 DEBUG : box root 'rclone-test-zoyupoc9decu': ["file3"(0)|file|ITEM_UPLOAD|1781694787180|d74a95a42bedeb5890b5fb6da1007502434f74fd] ignored due to duplicate EventID
2025/02/19 04:52:11 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425477816")
    fstests.go:935: Try 6/10 waiting for dirChanges and objChanges
2025/02/19 04:52:12 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425478830")
2025/02/19 04:52:13 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir1"(1)|folder|ITEM_TRASH|308124191451|af258cab04ef4e59f74617e0a9573e4f6b7bbce2] ignored due to duplicate EventID
2025/02/19 04:52:13 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(0)|folder|ITEM_CREATE|308126536759|f21a576e8aa9049798ac1e5e738660eacac3dc79] added new path ("dir/subdir3") for notify
2025/02/19 04:52:13 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/02/19 04:52:13 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 2 events, resulting in 1 paths and 1 notifications
2025/02/19 04:52:13 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425479814")
2025/02/19 04:52:13 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425480052")
2025/02/19 04:52:14 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir3"(0)|folder|ITEM_CREATE|308126536759|f21a576e8aa9049798ac1e5e738660eacac3dc79] ignored due to duplicate EventID
2025/02/19 04:52:14 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425480821")
    fstests.go:935: Try 7/10 waiting for dirChanges and objChanges
2025/02/19 04:52:15 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425481819")
2025/02/19 04:52:16 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425482826")
2025/02/19 04:52:17 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425483828")
2025/02/19 04:52:18 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir1"(0)|folder|ITEM_CREATE|308125588522|eda51c44c9d997f82978f856c29a151077430f4a] added new path ("dir/subdir1") for notify
2025/02/19 04:52:18 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/02/19 04:52:18 DEBUG : box root 'rclone-test-zoyupoc9decu': Received 1 events, resulting in 1 paths and 1 notifications
2025/02/19 04:52:18 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425484819")
2025/02/19 04:52:18 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir1"(0)|folder|ITEM_CREATE|308125588522|eda51c44c9d997f82978f856c29a151077430f4a] ignored due to duplicate EventID
    fstests.go:935: Try 8/10 waiting for dirChanges and objChanges
2025/02/19 04:52:18 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425485050")
2025/02/19 04:52:19 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir1"(0)|folder|ITEM_CREATE|308125588522|eda51c44c9d997f82978f856c29a151077430f4a] ignored due to duplicate EventID
2025/02/19 04:52:19 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425485810")
2025/02/19 04:52:20 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425486807")
2025/02/19 04:52:21 DEBUG : box root 'rclone-test-zoyupoc9decu': ["subdir1"(0)|folder|ITEM_CREATE|308125588522|eda51c44c9d997f82978f856c29a151077430f4a] ignored due to duplicate EventID
    fstests.go:935: Try 9/10 waiting for dirChanges and objChanges
2025/02/19 04:52:21 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425487807")
2025/02/19 04:52:22 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425488815")
2025/02/19 04:52:23 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425489810")
    fstests.go:939: map[dir:{} dir/subdir1:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file3:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/02/19 04:52:24 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425490808")
2025/02/19 04:52:25 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425491809")
2025/02/19 04:52:26 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425492810")
2025/02/19 04:52:27 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425493807")
2025/02/19 04:52:28 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425494813")
2025/02/19 04:52:29 DEBUG : box root 'rclone-test-zoyupoc9decu': Checking for changes on remote (next_stream_position: "30401037425495804")
2025/02/19 04:52:31 DEBUG : box root 'rclone-test-zoyupoc9decu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/02/19 04:52:31 ERROR : : error listing: directory not found
2025/02/19 04:52:31 DEBUG : box root 'rclone-test-zoyupoc9decu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (51.97s)
    --- FAIL: TestIntegration/FsMkdir (49.31s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (47.11s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/box	51.985s
"go test -v -timeout 1h0m0s -remote TestBox: -verbose -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 52.520631603s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]