"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/04/07 06:20:25 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-popimoz1foce"
2025/04/07 06:20:25 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/07 06:20:25 DEBUG : Creating backend with remote "TestBox:rclone-test-popimoz1foce"
2025/04/07 06:20:26 DEBUG : box root 'rclone-test-popimoz1foce': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/07 06:20:26 DEBUG : Reset feature "ListR"
2025/04/07 06:20:27 DEBUG : box root 'rclone-test-popimoz1foce': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/07 06:20:30 INFO  : dir: Making directory
2025/04/07 06:20:31 INFO  : dir/subdir1: Making directory
2025/04/07 06:20:32 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491578584")
2025/04/07 06:20:32 INFO  : dir/subdir3: Making directory
2025/04/07 06:20:33 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491579817")
2025/04/07 06:20:33 INFO  : dir/subdir2: Making directory
2025/04/07 06:20:34 DEBUG : box root 'rclone-test-popimoz1foce': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/07 06:20:34 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491580823")
2025/04/07 06:20:34 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491581064")
2025/04/07 06:20:35 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491581822")
2025/04/07 06:20:36 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491582825")
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir3"(1)|folder|ITEM_TRASH|315449216534|aa782de570472cee01e05e9f4d37b95e2cc70a44] ignored due to duplicate EventID
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir1"(0)|folder|ITEM_CREATE|315453242161|657e6e9b4d8d0e580a94a30cf383b60bf1f9fc36] added new path ("dir/subdir1") for notify
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["dir"(0)|folder|ITEM_CREATE|315453183911|308717e45ead9fecdc15bb856338c4860474bf12] added new path ("dir") for notify
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir3"(0)|folder|ITEM_CREATE|315453090567|391ffd33addd0db53e97aa3409d6759e976e9e40] added new path ("dir/subdir3") for notify
2025/04/07 06:20:37 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/07 06:20:37 DEBUG : doChangeNotify("dir", 0)
2025/04/07 06:20:37 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': Received 4 events, resulting in 3 paths and 3 notifications
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491584328")
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir1"(0)|folder|ITEM_CREATE|315453242161|657e6e9b4d8d0e580a94a30cf383b60bf1f9fc36] ignored due to duplicate EventID
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["dir"(0)|folder|ITEM_CREATE|315453183911|308717e45ead9fecdc15bb856338c4860474bf12] ignored due to duplicate EventID
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir3"(0)|folder|ITEM_CREATE|315453090567|391ffd33addd0db53e97aa3409d6759e976e9e40] ignored due to duplicate EventID
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': ["rclone-test-popimoz1foce"(0)|folder|ITEM_CREATE|315449701854|663c6a105bef6878f1f942328c8dac9988326c04] new parent not found
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': Received 4 events, resulting in 0 paths and 0 notifications
2025/04/07 06:20:37 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491584593")
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir1"(0)|folder|ITEM_CREATE|315453242161|657e6e9b4d8d0e580a94a30cf383b60bf1f9fc36] ignored due to duplicate EventID
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': ["dir"(0)|folder|ITEM_CREATE|315453183911|308717e45ead9fecdc15bb856338c4860474bf12] ignored due to duplicate EventID
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir3"(0)|folder|ITEM_CREATE|315453090567|391ffd33addd0db53e97aa3409d6759e976e9e40] ignored due to duplicate EventID
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': ["rclone-test-popimoz1foce"(0)|folder|ITEM_CREATE|315449701854|663c6a105bef6878f1f942328c8dac9988326c04] ignored due to duplicate EventID
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491584854")
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': ["dir"(0)|folder|ITEM_CREATE|315453183911|308717e45ead9fecdc15bb856338c4860474bf12] ignored due to duplicate EventID
2025/04/07 06:20:38 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491585096")
2025/04/07 06:20:39 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491585849")
2025/04/07 06:20:40 INFO  : dir/file2.rclone_chunk.001_c9w57p: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/07 06:20:40 INFO  : dir/file2.rclone_chunk.002_c9w57p: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/07 06:20:40 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491586848")
2025/04/07 06:20:42 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir3"(0)|folder|ITEM_CREATE|315453090567|391ffd33addd0db53e97aa3409d6759e976e9e40] ignored due to duplicate EventID
2025/04/07 06:20:42 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491588350")
2025/04/07 06:20:42 DEBUG : box root 'rclone-test-popimoz1foce': ["rclone-test-popimoz1foce"(0)|folder|ITEM_CREATE|315449701854|663c6a105bef6878f1f942328c8dac9988326c04] ignored due to duplicate EventID
2025/04/07 06:20:42 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491589180")
2025/04/07 06:20:43 DEBUG : box root 'rclone-test-popimoz1foce': ["subdir2"(0)|folder|ITEM_CREATE|315449694356|3ac94795fd7e4addc01a963e32d80c1053265283] added new path ("dir/subdir2") for notify
2025/04/07 06:20:43 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001_c9w57p"(0)|file|ITEM_UPLOAD|1826572741498|28e6c85d265605611a7f52a7500d19404a50d71d] added new path ("dir/file2.rclone_chunk.001_c9w57p") for notify
2025/04/07 06:20:43 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002_c9w57p"(0)|file|ITEM_UPLOAD|1826576383156|b7137dc5c81245590bfab101e4b1489f42f5b839] added new path ("dir/file2.rclone_chunk.002_c9w57p") for notify
2025/04/07 06:20:43 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/07 06:20:43 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_c9w57p", 1)
2025/04/07 06:20:43 DEBUG : doChangeNotify("dir/file2.rclone_chunk.002_c9w57p", 1)
2025/04/07 06:20:43 DEBUG : box root 'rclone-test-popimoz1foce': Received 3 events, resulting in 3 paths and 3 notifications
2025/04/07 06:20:43 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491589824")
2025/04/07 06:20:43 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491590588")
2025/04/07 06:20:44 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491590889")
2025/04/07 06:20:45 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001_c9w57p"(0)|file|ITEM_UPLOAD|1826572741498|28e6c85d265605611a7f52a7500d19404a50d71d] ignored due to duplicate EventID
2025/04/07 06:20:45 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491591816")
2025/04/07 06:20:46 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002_c9w57p"(0)|file|ITEM_UPLOAD|1826576383156|b7137dc5c81245590bfab101e4b1489f42f5b839] ignored due to duplicate EventID
2025/04/07 06:20:46 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491592819")
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(0)|file|ITEM_UPLOAD|1826567997060|7216b4965fd97838bd951932030157d6334eaff1] ignored due to old SequenceID ('\x00')
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1826572741498|d1298a48cf55cc7d90d6b88ef438e5d63865681b] ignored due to old SequenceID ('\x01')
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826576383156|f2bc47e554bf9a0f21a89b2e60f147a2dcd61e07] ignored due to old SequenceID ('\x01')
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491593828")
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(0)|file|ITEM_UPLOAD|1826567997060|7216b4965fd97838bd951932030157d6334eaff1] ignored due to duplicate EventID
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1826572741498|d1298a48cf55cc7d90d6b88ef438e5d63865681b] ignored due to duplicate EventID
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826576383156|f2bc47e554bf9a0f21a89b2e60f147a2dcd61e07] ignored due to duplicate EventID
2025/04/07 06:20:47 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491594081")
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(0)|file|ITEM_UPLOAD|1826567997060|7216b4965fd97838bd951932030157d6334eaff1] ignored due to duplicate EventID
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1826572741498|d1298a48cf55cc7d90d6b88ef438e5d63865681b] ignored due to duplicate EventID
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826576383156|f2bc47e554bf9a0f21a89b2e60f147a2dcd61e07] ignored due to duplicate EventID
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001_c9wd7k"(0)|file|ITEM_UPLOAD|1826573884485|fa95f7b742684193b3957de70e7a77b90099c92e] added new path ("dir/file4.rclone_chunk.001_c9wd7k") for notify
2025/04/07 06:20:48 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_c9wd7k", 1)
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': Received 4 events, resulting in 1 paths and 1 notifications
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491594830")
2025/04/07 06:20:48 INFO  : dir/file4.rclone_chunk.001_c9wd7k: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/07 06:20:48 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491595085")
2025/04/07 06:20:49 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1826572741498|d1298a48cf55cc7d90d6b88ef438e5d63865681b] ignored due to duplicate EventID
2025/04/07 06:20:49 INFO  : dir/file4.rclone_chunk.002_c9wd7k: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/07 06:20:49 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491595812")
2025/04/07 06:20:50 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491596822")
2025/04/07 06:20:51 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826576383156|f2bc47e554bf9a0f21a89b2e60f147a2dcd61e07] ignored due to duplicate EventID
2025/04/07 06:20:51 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491597825")
2025/04/07 06:20:52 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001_c9wd7k"(0)|file|ITEM_UPLOAD|1826573884485|fa95f7b742684193b3957de70e7a77b90099c92e] ignored due to duplicate EventID
2025/04/07 06:20:52 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491598846")
2025/04/07 06:20:53 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002_c9wd7k"(0)|file|ITEM_UPLOAD|1826573911061|5dc586cfcef8b4bce7fe3eaecf18ea8471b214aa] ignored due to old SequenceID ('\x01')
2025/04/07 06:20:53 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1826573911061|7005cd0b2f9cfeb48a7a560f95db10fad079404a] ignored due to old SequenceID ('\x01')
2025/04/07 06:20:53 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826573884485|e80b33b6ccfbfc3a0ca090738d3ae73ab4db2675] ignored due to old SequenceID ('\x01')
2025/04/07 06:20:53 DEBUG : box root 'rclone-test-popimoz1foce': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/07 06:20:53 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491599832")
2025/04/07 06:20:53 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491600087")
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002_c9wd7k"(0)|file|ITEM_UPLOAD|1826573911061|5dc586cfcef8b4bce7fe3eaecf18ea8471b214aa] ignored due to duplicate EventID
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1826573911061|7005cd0b2f9cfeb48a7a560f95db10fad079404a] ignored due to duplicate EventID
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826573884485|e80b33b6ccfbfc3a0ca090738d3ae73ab4db2675] ignored due to duplicate EventID
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(0)|file|ITEM_UPLOAD|1826584067308|a61b02763c7497a9669a784926cca967d7f1567e] ignored due to old SequenceID ('\x00')
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': Received 4 events, resulting in 0 paths and 0 notifications
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491600822")
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002_c9wd7k"(0)|file|ITEM_UPLOAD|1826573911061|5dc586cfcef8b4bce7fe3eaecf18ea8471b214aa] ignored due to duplicate EventID
2025/04/07 06:20:54 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491601076")
2025/04/07 06:20:55 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1826573911061|7005cd0b2f9cfeb48a7a560f95db10fad079404a] ignored due to duplicate EventID
2025/04/07 06:20:55 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826573884485|e80b33b6ccfbfc3a0ca090738d3ae73ab4db2675] ignored due to duplicate EventID
2025/04/07 06:20:55 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(0)|file|ITEM_UPLOAD|1826584067308|a61b02763c7497a9669a784926cca967d7f1567e] ignored due to duplicate EventID
2025/04/07 06:20:55 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491601822")
2025/04/07 06:20:56 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826573884485|e80b33b6ccfbfc3a0ca090738d3ae73ab4db2675] ignored due to duplicate EventID
2025/04/07 06:20:56 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(0)|file|ITEM_UPLOAD|1826584067308|a61b02763c7497a9669a784926cca967d7f1567e] ignored due to duplicate EventID
2025/04/07 06:20:56 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491602820")
2025/04/07 06:20:57 INFO  : dir/file3.rclone_chunk.001_c9wm4n: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/07 06:20:57 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826573884485|e80b33b6ccfbfc3a0ca090738d3ae73ab4db2675] ignored due to duplicate EventID
2025/04/07 06:20:57 INFO  : dir/file3.rclone_chunk.002_c9wm4n: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/07 06:20:57 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491603822")
2025/04/07 06:20:58 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(0)|file|ITEM_UPLOAD|1826584067308|a61b02763c7497a9669a784926cca967d7f1567e] ignored due to duplicate EventID
2025/04/07 06:20:58 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491604816")
2025/04/07 06:20:59 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.002_c9wm4n"(0)|file|ITEM_UPLOAD|1826578177352|da3b6585f214e08df487f1b8d939e8d7769f8ca7] added new path ("dir/file3.rclone_chunk.002_c9wm4n") for notify
2025/04/07 06:20:59 DEBUG : doChangeNotify("dir/file3.rclone_chunk.002_c9wm4n", 1)
2025/04/07 06:20:59 DEBUG : box root 'rclone-test-popimoz1foce': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/07 06:20:59 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491605832")
2025/04/07 06:20:59 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491606089")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/07 06:21:00 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491606829")
2025/04/07 06:21:01 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.002_c9wm4n"(0)|file|ITEM_UPLOAD|1826578177352|da3b6585f214e08df487f1b8d939e8d7769f8ca7] ignored due to duplicate EventID
2025/04/07 06:21:01 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1826578177352|2a51a25b58a4daab2c4de940053b1ce333dac24f] ignored due to old SequenceID ('\x01')
2025/04/07 06:21:01 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001_c9wm4n"(0)|file|ITEM_UPLOAD|1826566921496|c2747cb9899039378b2c08fd8a19c7555c770614] ignored due to old SequenceID ('\x01')
2025/04/07 06:21:01 DEBUG : box root 'rclone-test-popimoz1foce': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/07 06:21:01 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491607816")
2025/04/07 06:21:01 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491608104")
2025/04/07 06:21:02 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491608835")
2025/04/07 06:21:03 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.002_c9wm4n"(0)|file|ITEM_UPLOAD|1826578177352|da3b6585f214e08df487f1b8d939e8d7769f8ca7] ignored due to duplicate EventID
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/07 06:21:03 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491609817")
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1826578177352|2a51a25b58a4daab2c4de940053b1ce333dac24f] ignored due to duplicate EventID
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001_c9wm4n"(0)|file|ITEM_UPLOAD|1826566921496|c2747cb9899039378b2c08fd8a19c7555c770614] ignored due to duplicate EventID
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': ["file3"(0)|file|ITEM_UPLOAD|1826579233885|85306575966c6d94af29580f06df2fbf0093c394] ignored due to old SequenceID ('\x00')
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826566921496|614221a7b977b17bac7a916fe082195795696775] ignored due to old SequenceID ('\x01')
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': Received 4 events, resulting in 0 paths and 0 notifications
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491610827")
2025/04/07 06:21:04 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491611102")
2025/04/07 06:21:05 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001_c9wm4n"(0)|file|ITEM_UPLOAD|1826566921496|c2747cb9899039378b2c08fd8a19c7555c770614] ignored due to duplicate EventID
2025/04/07 06:21:05 DEBUG : box root 'rclone-test-popimoz1foce': ["file3"(0)|file|ITEM_UPLOAD|1826579233885|85306575966c6d94af29580f06df2fbf0093c394] ignored due to duplicate EventID
2025/04/07 06:21:05 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826566921496|614221a7b977b17bac7a916fe082195795696775] ignored due to duplicate EventID
2025/04/07 06:21:05 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491611870")
2025/04/07 06:21:06 DEBUG : box root 'rclone-test-popimoz1foce': ["file3"(0)|file|ITEM_UPLOAD|1826579233885|85306575966c6d94af29580f06df2fbf0093c394] ignored due to duplicate EventID
2025/04/07 06:21:06 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826566921496|614221a7b977b17bac7a916fe082195795696775] ignored due to duplicate EventID
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/07 06:21:06 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491612823")
2025/04/07 06:21:07 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491613831")
2025/04/07 06:21:08 DEBUG : box root 'rclone-test-popimoz1foce': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826566921496|614221a7b977b17bac7a916fe082195795696775] ignored due to duplicate EventID
2025/04/07 06:21:08 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491614814")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/07 06:21:09 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491615821")
2025/04/07 06:21:10 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491616838")
2025/04/07 06:21:11 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491617829")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/07 06:21:12 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491618832")
2025/04/07 06:21:13 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491619817")
2025/04/07 06:21:14 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491620838")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/07 06:21:15 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491621819")
2025/04/07 06:21:16 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491622819")
2025/04/07 06:21:17 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491623822")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/07 06:21:18 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491624818")
2025/04/07 06:21:19 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491625823")
2025/04/07 06:21:20 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491626821")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/07 06:21:21 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491627819")
2025/04/07 06:21:22 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491628837")
2025/04/07 06:21:23 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491629832")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/07 06:21:24 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491630832")
2025/04/07 06:21:25 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491631833")
2025/04/07 06:21:26 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491632867")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2.rclone_chunk.001_c9w57p:{} dir/file2.rclone_chunk.002_c9w57p:{} dir/file3.rclone_chunk.002_c9wm4n:{} dir/file4.rclone_chunk.001_c9wd7k:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/07 06:21:27 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491633839")
2025/04/07 06:21:28 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491634832")
2025/04/07 06:21:29 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491635815")
2025/04/07 06:21:30 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491636814")
2025/04/07 06:21:31 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491637859")
2025/04/07 06:21:32 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491638822")
2025/04/07 06:21:33 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491639825")
2025/04/07 06:21:34 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491640840")
2025/04/07 06:21:35 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(1)|file|ITEM_TRASH|1826567997060|cf2f711ae48753a22fcd1abb06d98294567ab4ad] added old path ("dir/file2") for notify
2025/04/07 06:21:35 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1826572741498|c7c3077801a32bec5e74598464f214e6c8ae5de8] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/07 06:21:35 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826576383156|ce8bd0447637e78ef6cd95f7675a76dc50e9d277] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/07 06:21:35 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/07 06:21:35 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/07 06:21:35 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/07 06:21:35 DEBUG : box root 'rclone-test-popimoz1foce': Received 3 events, resulting in 3 paths and 3 notifications
2025/04/07 06:21:35 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491641818")
2025/04/07 06:21:35 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491642078")
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(1)|file|ITEM_TRASH|1826567997060|cf2f711ae48753a22fcd1abb06d98294567ab4ad] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1826572741498|c7c3077801a32bec5e74598464f214e6c8ae5de8] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826576383156|ce8bd0447637e78ef6cd95f7675a76dc50e9d277] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(1)|file|ITEM_TRASH|1826584067308|c40b7f61257071d047febeec29257c7de485c136] added old path ("dir/file4") for notify
2025/04/07 06:21:36 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': Received 4 events, resulting in 1 paths and 1 notifications
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491642823")
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(1)|file|ITEM_TRASH|1826567997060|cf2f711ae48753a22fcd1abb06d98294567ab4ad] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1826572741498|c7c3077801a32bec5e74598464f214e6c8ae5de8] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826576383156|ce8bd0447637e78ef6cd95f7675a76dc50e9d277] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(1)|file|ITEM_TRASH|1826584067308|c40b7f61257071d047febeec29257c7de485c136] ignored due to duplicate EventID
2025/04/07 06:21:36 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491643129")
2025/04/07 06:21:37 DEBUG : box root 'rclone-test-popimoz1foce': ["file2"(1)|file|ITEM_TRASH|1826567997060|cf2f711ae48753a22fcd1abb06d98294567ab4ad] ignored due to duplicate EventID
2025/04/07 06:21:37 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1826572741498|c7c3077801a32bec5e74598464f214e6c8ae5de8] ignored due to duplicate EventID
2025/04/07 06:21:37 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491643814")
2025/04/07 06:21:38 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491644819")
2025/04/07 06:21:39 DEBUG : box root 'rclone-test-popimoz1foce': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826576383156|ce8bd0447637e78ef6cd95f7675a76dc50e9d277] ignored due to duplicate EventID
2025/04/07 06:21:39 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(1)|file|ITEM_TRASH|1826584067308|c40b7f61257071d047febeec29257c7de485c136] ignored due to duplicate EventID
2025/04/07 06:21:39 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826573884485|ed704830aa87d92d4b3b28db1ea1fe9dbec485b5] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/07 06:21:39 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/07 06:21:39 DEBUG : box root 'rclone-test-popimoz1foce': Received 3 events, resulting in 1 paths and 1 notifications
2025/04/07 06:21:39 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491645835")
2025/04/07 06:21:39 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491646124")
2025/04/07 06:21:40 DEBUG : box root 'rclone-test-popimoz1foce': ["file4"(1)|file|ITEM_TRASH|1826584067308|c40b7f61257071d047febeec29257c7de485c136] ignored due to duplicate EventID
2025/04/07 06:21:40 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491646815")
2025/04/07 06:21:41 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826573884485|ed704830aa87d92d4b3b28db1ea1fe9dbec485b5] ignored due to duplicate EventID
2025/04/07 06:21:41 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491647817")
2025/04/07 06:21:42 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1826573911061|156098135f7ae56bfea9c3c6581ebe387ac3968f] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/07 06:21:42 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/07 06:21:42 DEBUG : box root 'rclone-test-popimoz1foce': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/07 06:21:42 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491648831")
2025/04/07 06:21:42 DEBUG : box root 'rclone-test-popimoz1foce': Checking for changes on remote (next_stream_position: "30401041491649098")
2025/04/07 06:21:43 DEBUG : box root 'rclone-test-popimoz1foce': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1826573911061|156098135f7ae56bfea9c3c6581ebe387ac3968f] ignored due to duplicate EventID
2025/04/07 06:21:45 DEBUG : box root 'rclone-test-popimoz1foce': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/07 06:21:45 ERROR : : error listing: directory not found
2025/04/07 06:21:45 DEBUG : box root 'rclone-test-popimoz1foce': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (80.39s)
    --- FAIL: TestIntegration/FsMkdir (75.99s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (73.30s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	80.427s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m22.902195525s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]