"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 5/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/12 07:35:23 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vupirem3baxu"
2025/03/12 07:35:23 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/12 07:35:23 DEBUG : Creating backend with remote "TestBox:rclone-test-vupirem3baxu"
2025/03/12 07:35:23 DEBUG : box root 'rclone-test-vupirem3baxu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/12 07:35:23 DEBUG : Reset feature "ListR"
2025/03/12 07:35:24 DEBUG : box root 'rclone-test-vupirem3baxu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/12 07:35:25 INFO  : dir: Making directory
2025/03/12 07:35:26 INFO  : dir/subdir1: Making directory
2025/03/12 07:35:27 INFO  : dir/subdir3: Making directory
2025/03/12 07:35:27 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249673565")
2025/03/12 07:35:28 INFO  : dir/subdir2: Making directory
2025/03/12 07:35:28 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249674790")
2025/03/12 07:35:29 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249675781")
2025/03/12 07:35:30 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249676789")
2025/03/12 07:35:31 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249677784")
2025/03/12 07:35:32 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249678786")
2025/03/12 07:35:33 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249679788")
2025/03/12 07:35:33 INFO  : dir/file2.rclone_chunk.001_080t16: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/12 07:35:34 INFO  : dir/file2.rclone_chunk.002_080t16: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/12 07:35:34 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249680788")
2025/03/12 07:35:35 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249681782")
2025/03/12 07:35:36 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249682788")
2025/03/12 07:35:37 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249683784")
2025/03/12 07:35:38 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249684781")
2025/03/12 07:35:39 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249685782")
2025/03/12 07:35:40 INFO  : dir/file4.rclone_chunk.001_08100z: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/12 07:35:40 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249686783")
2025/03/12 07:35:41 INFO  : dir/file4.rclone_chunk.002_08100z: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/12 07:35:41 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249687788")
2025/03/12 07:35:42 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249688796")
2025/03/12 07:35:43 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249689793")
2025/03/12 07:35:44 DEBUG : box root 'rclone-test-vupirem3baxu': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:44 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249690832")
2025/03/12 07:35:44 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249691060")
2025/03/12 07:35:45 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(1)|file|ITEM_TRASH|1800812931865|b69ecd180cede1bae83b0dca780a1cf83d035901] ignored due to duplicate EventID
2025/03/12 07:35:45 DEBUG : box root 'rclone-test-vupirem3baxu': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:45 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249691815")
2025/03/12 07:35:45 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(1)|file|ITEM_TRASH|1800812931865|b69ecd180cede1bae83b0dca780a1cf83d035901] ignored due to duplicate EventID
2025/03/12 07:35:45 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1800799858803|ec47d430fa6594f1c2bf3e8e2a7f0bbc464ef1ab] ignored due to duplicate EventID
2025/03/12 07:35:45 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249692108")
2025/03/12 07:35:46 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(1)|file|ITEM_TRASH|1800812931865|b69ecd180cede1bae83b0dca780a1cf83d035901] ignored due to duplicate EventID
2025/03/12 07:35:46 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249692813")
2025/03/12 07:35:47 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249693901")
2025/03/12 07:35:48 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249694875")
2025/03/12 07:35:49 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1800799858803|ec47d430fa6594f1c2bf3e8e2a7f0bbc464ef1ab] ignored due to duplicate EventID
2025/03/12 07:35:49 INFO  : dir/file3.rclone_chunk.001_08178h: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/12 07:35:49 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249695882")
2025/03/12 07:35:49 INFO  : dir/file3.rclone_chunk.002_08178h: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/12 07:35:50 DEBUG : box root 'rclone-test-vupirem3baxu': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:50 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249696917")
2025/03/12 07:35:50 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3"(1)|file|ITEM_TRASH|1800814053536|b694c30f5d8e9543043b42cf5fdb0a4361a66343] ignored due to duplicate EventID
2025/03/12 07:35:50 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4"(1)|file|ITEM_TRASH|1800816760470|292101f4dca5167bd97f0dc69a91d5d18e171fdf] ignored due to duplicate EventID
2025/03/12 07:35:50 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir1"(1)|folder|ITEM_TRASH|311310669288|e568ac3008da6136b7f2c116ab8ae03a963a9b93] ignored due to duplicate EventID
2025/03/12 07:35:50 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249697207")
2025/03/12 07:35:51 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4"(1)|file|ITEM_TRASH|1800816760470|292101f4dca5167bd97f0dc69a91d5d18e171fdf] ignored due to duplicate EventID
2025/03/12 07:35:51 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir1"(1)|folder|ITEM_TRASH|311310669288|e568ac3008da6136b7f2c116ab8ae03a963a9b93] ignored due to duplicate EventID
2025/03/12 07:35:51 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir3"(0)|folder|ITEM_CREATE|311311379137|2f541d9710fa087fbf5339e9c58ef21a9d9c43b4] ignored due to old SequenceID ('\x00')
2025/03/12 07:35:51 DEBUG : box root 'rclone-test-vupirem3baxu': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:51 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249697906")
2025/03/12 07:35:51 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249698213")
2025/03/12 07:35:52 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249698911")
2025/03/12 07:35:53 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4"(1)|file|ITEM_TRASH|1800816760470|292101f4dca5167bd97f0dc69a91d5d18e171fdf] ignored due to duplicate EventID
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/12 07:35:53 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249699864")
2025/03/12 07:35:54 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir1"(1)|folder|ITEM_TRASH|311310669288|e568ac3008da6136b7f2c116ab8ae03a963a9b93] ignored due to duplicate EventID
2025/03/12 07:35:54 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir3"(0)|folder|ITEM_CREATE|311311379137|2f541d9710fa087fbf5339e9c58ef21a9d9c43b4] ignored due to duplicate EventID
2025/03/12 07:35:54 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1800816325585|7593cb4e8ec1d3a4429e4d3f5ae8ca678112abbe] ignored due to duplicate EventID
2025/03/12 07:35:54 DEBUG : box root 'rclone-test-vupirem3baxu': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:54 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249700869")
2025/03/12 07:35:54 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249701222")
2025/03/12 07:35:55 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir3"(0)|folder|ITEM_CREATE|311311379137|2f541d9710fa087fbf5339e9c58ef21a9d9c43b4] ignored due to duplicate EventID
2025/03/12 07:35:55 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249701838")
2025/03/12 07:35:56 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1800816325585|7593cb4e8ec1d3a4429e4d3f5ae8ca678112abbe] ignored due to duplicate EventID
2025/03/12 07:35:56 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1800800646632|15e1655fe0e589d8ef6de8c03fa5df090304c917] ignored due to duplicate EventID
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/12 07:35:56 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249702881")
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(0)|folder|ITEM_CREATE|311309442588|048b87c469450654a090fc7e66b280abc6164aba] ignored due to old SequenceID ('\x00')
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249703832")
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1800816608448|76e404af72ec3d03d7932adcfa798dad3a72a640] ignored due to duplicate EventID
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(0)|folder|ITEM_CREATE|311309442588|048b87c469450654a090fc7e66b280abc6164aba] ignored due to duplicate EventID
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(1)|folder|ITEM_TRASH|311309931933|e0fb5d7540d727b9c5ff3e07a3cd515949e9475d] ignored due to duplicate EventID
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-lasidom6wixu"(1)|folder|ITEM_TRASH|311307462727|50bb6caaa1cf0a7a758102b3de85306f0d7290b2] ignored due to duplicate EventID
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(0)|folder|ITEM_CREATE|311310625874|1e9978018d4ce8c0f6135ddd016ee750bf6be7c1] added new path ("dir") for notify
2025/03/12 07:35:57 DEBUG : doChangeNotify("dir", 0)
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': Received 5 events, resulting in 1 paths and 1 notifications
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249704119")
2025/03/12 07:35:57 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249704406")
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1800816608448|76e404af72ec3d03d7932adcfa798dad3a72a640] ignored due to duplicate EventID
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(0)|folder|ITEM_CREATE|311309442588|048b87c469450654a090fc7e66b280abc6164aba] ignored due to duplicate EventID
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(1)|folder|ITEM_TRASH|311309931933|e0fb5d7540d727b9c5ff3e07a3cd515949e9475d] ignored due to duplicate EventID
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-lasidom6wixu"(1)|folder|ITEM_TRASH|311307462727|50bb6caaa1cf0a7a758102b3de85306f0d7290b2] ignored due to duplicate EventID
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(0)|folder|ITEM_CREATE|311310625874|1e9978018d4ce8c0f6135ddd016ee750bf6be7c1] ignored due to duplicate EventID
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001_080t16"(0)|file|ITEM_UPLOAD|1800810481489|8c0bfd638d595c732c4affee7db67b08ac3a19db] ignored due to old SequenceID ('\x01')
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': Received 7 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249704824")
2025/03/12 07:35:58 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249705161")
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1800816608448|76e404af72ec3d03d7932adcfa798dad3a72a640] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(0)|folder|ITEM_CREATE|311309442588|048b87c469450654a090fc7e66b280abc6164aba] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(1)|folder|ITEM_TRASH|311309931933|e0fb5d7540d727b9c5ff3e07a3cd515949e9475d] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-lasidom6wixu"(1)|folder|ITEM_TRASH|311307462727|50bb6caaa1cf0a7a758102b3de85306f0d7290b2] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(0)|folder|ITEM_CREATE|311310625874|1e9978018d4ce8c0f6135ddd016ee750bf6be7c1] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(1)|folder|ITEM_TRASH|311310592317|60250786715dcbd843abbceb03c260c274d429dc] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001_080t16"(0)|file|ITEM_UPLOAD|1800810481489|8c0bfd638d595c732c4affee7db67b08ac3a19db] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': Received 8 events, resulting in 0 paths and 0 notifications
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249705844")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(1)|folder|ITEM_TRASH|311309931933|e0fb5d7540d727b9c5ff3e07a3cd515949e9475d] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-lasidom6wixu"(1)|folder|ITEM_TRASH|311307462727|50bb6caaa1cf0a7a758102b3de85306f0d7290b2] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(0)|folder|ITEM_CREATE|311310625874|1e9978018d4ce8c0f6135ddd016ee750bf6be7c1] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(1)|folder|ITEM_TRASH|311310592317|60250786715dcbd843abbceb03c260c274d429dc] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001_080t16"(0)|file|ITEM_UPLOAD|1800810481489|8c0bfd638d595c732c4affee7db67b08ac3a19db] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1800815082223|7cf4b26e1107924dcd3ef09107c9a5ec700ec879] ignored due to duplicate EventID
2025/03/12 07:35:59 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249706182")
2025/03/12 07:36:00 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249706846")
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(1)|folder|ITEM_TRASH|311309931933|e0fb5d7540d727b9c5ff3e07a3cd515949e9475d] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-lasidom6wixu"(1)|folder|ITEM_TRASH|311307462727|50bb6caaa1cf0a7a758102b3de85306f0d7290b2] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["dir"(0)|folder|ITEM_CREATE|311310625874|1e9978018d4ce8c0f6135ddd016ee750bf6be7c1] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(1)|folder|ITEM_TRASH|311310592317|60250786715dcbd843abbceb03c260c274d429dc] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001_080t16"(0)|file|ITEM_UPLOAD|1800810481489|8c0bfd638d595c732c4affee7db67b08ac3a19db] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1800815082223|7cf4b26e1107924dcd3ef09107c9a5ec700ec879] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(0)|file|ITEM_UPLOAD|1800817463754|eef3d37adcbf0421f9b8410e814a2673c0c82a7f] ignored due to old SequenceID ('\x00')
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002_080t16"(0)|file|ITEM_UPLOAD|1800809461259|9f2ca7acb0ad8f0b84cff12814a8819a77216c3f] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': Received 8 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249707969")
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir2"(1)|folder|ITEM_TRASH|311310592317|60250786715dcbd843abbceb03c260c274d429dc] ignored due to duplicate EventID
2025/03/12 07:36:01 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249708494")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001_080t16"(0)|file|ITEM_UPLOAD|1800810481489|8c0bfd638d595c732c4affee7db67b08ac3a19db] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1800815082223|7cf4b26e1107924dcd3ef09107c9a5ec700ec879] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(0)|file|ITEM_UPLOAD|1800817463754|eef3d37adcbf0421f9b8410e814a2673c0c82a7f] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002_080t16"(0)|file|ITEM_UPLOAD|1800809461259|9f2ca7acb0ad8f0b84cff12814a8819a77216c3f] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001_08178h"(0)|file|ITEM_UPLOAD|1800817232769|7735f9c606af7e2c11bc1bc260a09f17051f6023] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800810481489|1d26057f9c8a3d3b0267c66e060717bd2b51dfa8] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': Received 6 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249708970")
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1800815082223|7cf4b26e1107924dcd3ef09107c9a5ec700ec879] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(0)|file|ITEM_UPLOAD|1800817463754|eef3d37adcbf0421f9b8410e814a2673c0c82a7f] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002_080t16"(0)|file|ITEM_UPLOAD|1800809461259|9f2ca7acb0ad8f0b84cff12814a8819a77216c3f] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001_08178h"(0)|file|ITEM_UPLOAD|1800817232769|7735f9c606af7e2c11bc1bc260a09f17051f6023] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800810481489|1d26057f9c8a3d3b0267c66e060717bd2b51dfa8] ignored due to duplicate EventID
2025/03/12 07:36:02 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249709303")
2025/03/12 07:36:03 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1800815082223|7cf4b26e1107924dcd3ef09107c9a5ec700ec879] ignored due to duplicate EventID
2025/03/12 07:36:03 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249709842")
2025/03/12 07:36:04 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249710851")
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2"(0)|file|ITEM_UPLOAD|1800817463754|eef3d37adcbf0421f9b8410e814a2673c0c82a7f] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002_080t16"(0)|file|ITEM_UPLOAD|1800809461259|9f2ca7acb0ad8f0b84cff12814a8819a77216c3f] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001_08178h"(0)|file|ITEM_UPLOAD|1800817232769|7735f9c606af7e2c11bc1bc260a09f17051f6023] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800810481489|1d26057f9c8a3d3b0267c66e060717bd2b51dfa8] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800817581005|16a162a5cb2806802f6ca110d5b607a92d01dc27] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001_08100z"(0)|file|ITEM_UPLOAD|1800813126666|ca0313d34ca52a6311d45b84c7d3a4df2262a2e0] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800809461259|7e5d0eddb72b790433c0c1e1c96114388d883492] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': Received 8 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249711812")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001_08178h"(0)|file|ITEM_UPLOAD|1800817232769|7735f9c606af7e2c11bc1bc260a09f17051f6023] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800810481489|1d26057f9c8a3d3b0267c66e060717bd2b51dfa8] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800817581005|16a162a5cb2806802f6ca110d5b607a92d01dc27] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1800816757725|51885c08bdaa59631def24e2817c8a8a58955a94] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001_08100z"(0)|file|ITEM_UPLOAD|1800813126666|ca0313d34ca52a6311d45b84c7d3a4df2262a2e0] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800809461259|7e5d0eddb72b790433c0c1e1c96114388d883492] ignored due to duplicate EventID
2025/03/12 07:36:05 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249712097")
2025/03/12 07:36:06 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001_08178h"(0)|file|ITEM_UPLOAD|1800817232769|7735f9c606af7e2c11bc1bc260a09f17051f6023] ignored due to duplicate EventID
2025/03/12 07:36:06 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249712824")
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1800810481489|1d26057f9c8a3d3b0267c66e060717bd2b51dfa8] ignored due to duplicate EventID
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800817581005|16a162a5cb2806802f6ca110d5b607a92d01dc27] ignored due to duplicate EventID
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1800816757725|51885c08bdaa59631def24e2817c8a8a58955a94] ignored due to duplicate EventID
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001_08100z"(0)|file|ITEM_UPLOAD|1800813126666|ca0313d34ca52a6311d45b84c7d3a4df2262a2e0] ignored due to duplicate EventID
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800809461259|7e5d0eddb72b790433c0c1e1c96114388d883492] ignored due to duplicate EventID
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-vupirem3baxu"(0)|folder|ITEM_CREATE|311308175997|5497fdb48cde9c56ede7c97123f581a7584cb9e3] new parent not found
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': Received 6 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249713805")
2025/03/12 07:36:07 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249714087")
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1800817581005|16a162a5cb2806802f6ca110d5b607a92d01dc27] ignored due to duplicate EventID
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1800816757725|51885c08bdaa59631def24e2817c8a8a58955a94] ignored due to duplicate EventID
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001_08100z"(0)|file|ITEM_UPLOAD|1800813126666|ca0313d34ca52a6311d45b84c7d3a4df2262a2e0] ignored due to duplicate EventID
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800809461259|7e5d0eddb72b790433c0c1e1c96114388d883492] ignored due to duplicate EventID
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-vupirem3baxu"(0)|folder|ITEM_CREATE|311308175997|5497fdb48cde9c56ede7c97123f581a7584cb9e3] ignored due to duplicate EventID
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': Received 6 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249714827")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/12 07:36:08 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249715126")
2025/03/12 07:36:09 DEBUG : box root 'rclone-test-vupirem3baxu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1800809461259|7e5d0eddb72b790433c0c1e1c96114388d883492] ignored due to duplicate EventID
2025/03/12 07:36:09 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249715805")
2025/03/12 07:36:10 DEBUG : box root 'rclone-test-vupirem3baxu': ["rclone-test-vupirem3baxu"(0)|folder|ITEM_CREATE|311308175997|5497fdb48cde9c56ede7c97123f581a7584cb9e3] ignored due to duplicate EventID
2025/03/12 07:36:10 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249716804")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/12 07:36:11 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249717833")
2025/03/12 07:36:12 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir3"(1)|folder|ITEM_TRASH|311309272120|1d39cb750e128ae84004e825ac042d2af6dcf7eb] ignored due to duplicate EventID
2025/03/12 07:36:12 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249718819")
2025/03/12 07:36:13 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249719801")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/12 07:36:14 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249720804")
2025/03/12 07:36:15 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249721793")
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["subdir1"(0)|folder|ITEM_CREATE|311311053091|c44c77116d2c4849b87e75d6c7860feb9431d6b5] ignored due to old SequenceID ('\x00')
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1800813126666|fe2fbdffc75479d9166e4aabd63a310f7d5d678c] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800817232769|fa9f42da5ff838a191d1fe589e23ddbe7c046277] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3"(0)|file|ITEM_UPLOAD|1800800822362|2e4d51ad48cc47ade57d0bdea15c36d3fc070382] ignored due to old SequenceID ('\x00')
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249722802")
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1800813126666|fe2fbdffc75479d9166e4aabd63a310f7d5d678c] ignored due to duplicate EventID
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800817232769|fa9f42da5ff838a191d1fe589e23ddbe7c046277] ignored due to duplicate EventID
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3"(0)|file|ITEM_UPLOAD|1800800822362|2e4d51ad48cc47ade57d0bdea15c36d3fc070382] ignored due to duplicate EventID
2025/03/12 07:36:16 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249723063")
2025/03/12 07:36:17 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1800813126666|fe2fbdffc75479d9166e4aabd63a310f7d5d678c] ignored due to duplicate EventID
2025/03/12 07:36:17 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800817232769|fa9f42da5ff838a191d1fe589e23ddbe7c046277] ignored due to duplicate EventID
2025/03/12 07:36:17 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3"(0)|file|ITEM_UPLOAD|1800800822362|2e4d51ad48cc47ade57d0bdea15c36d3fc070382] ignored due to duplicate EventID
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/12 07:36:17 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249723790")
2025/03/12 07:36:18 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1800813126666|fe2fbdffc75479d9166e4aabd63a310f7d5d678c] ignored due to duplicate EventID
2025/03/12 07:36:18 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1800817232769|fa9f42da5ff838a191d1fe589e23ddbe7c046277] ignored due to duplicate EventID
2025/03/12 07:36:18 DEBUG : box root 'rclone-test-vupirem3baxu': ["file3"(0)|file|ITEM_UPLOAD|1800800822362|2e4d51ad48cc47ade57d0bdea15c36d3fc070382] ignored due to duplicate EventID
2025/03/12 07:36:18 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249724814")
2025/03/12 07:36:19 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249725805")
    fstests.go:935: map[dir:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/12 07:36:20 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249726801")
2025/03/12 07:36:21 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249727785")
2025/03/12 07:36:22 DEBUG : box root 'rclone-test-vupirem3baxu': ["file4.rclone_chunk.002_08100z"(0)|file|ITEM_UPLOAD|1800817581005|1efbda588be286b57e3e7d442bd407a58f076659] ignored due to old SequenceID ('\x01')
2025/03/12 07:36:22 DEBUG : box root 'rclone-test-vupirem3baxu': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/12 07:36:22 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249728787")
2025/03/12 07:36:22 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249729009")
2025/03/12 07:36:23 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249729791")
2025/03/12 07:36:24 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249730788")
2025/03/12 07:36:25 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249731787")
2025/03/12 07:36:26 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249732809")
2025/03/12 07:36:27 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249733782")
2025/03/12 07:36:28 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249734791")
2025/03/12 07:36:29 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249735791")
2025/03/12 07:36:30 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249736786")
2025/03/12 07:36:31 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249737790")
2025/03/12 07:36:32 DEBUG : box root 'rclone-test-vupirem3baxu': Checking for changes on remote (next_stream_position: "30401039249738798")
2025/03/12 07:36:34 DEBUG : box root 'rclone-test-vupirem3baxu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/12 07:36:34 ERROR : : error listing: directory not found
2025/03/12 07:36:34 DEBUG : box root 'rclone-test-vupirem3baxu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (71.53s)
    --- FAIL: TestIntegration/FsMkdir (69.29s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (67.24s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	71.563s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m13.659931448s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]