"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/04/07 06:21:48 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-zupegub5futo"
2025/04/07 06:21:48 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/07 06:21:48 DEBUG : Creating backend with remote "TestBox:rclone-test-zupegub5futo"
2025/04/07 06:21:48 DEBUG : box root 'rclone-test-zupegub5futo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/07 06:21:49 DEBUG : Reset feature "ListR"
2025/04/07 06:21:50 DEBUG : box root 'rclone-test-zupegub5futo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/07 06:21:52 INFO  : dir: Making directory
2025/04/07 06:21:53 INFO  : dir/subdir1: Making directory
2025/04/07 06:21:54 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491660105")
2025/04/07 06:21:54 INFO  : dir/subdir3: Making directory
2025/04/07 06:21:54 DEBUG : box root 'rclone-test-zupegub5futo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/07 06:21:54 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491661359")
2025/04/07 06:21:55 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491661643")
2025/04/07 06:21:55 INFO  : dir/subdir2: Making directory
2025/04/07 06:21:56 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491662370")
2025/04/07 06:21:57 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491663364")
2025/04/07 06:21:57 DEBUG : box root 'rclone-test-zupegub5futo': ["dir"(0)|folder|ITEM_CREATE|315451124707|3c4b1e678fad793336ccc1355b1b8fd095f057ee] added new path ("dir") for notify
2025/04/07 06:21:57 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir1"(0)|folder|ITEM_CREATE|315450894646|e2300a9c74ad4b014ec8e986a6df3a24edf60df9] added new path ("dir/subdir1") for notify
2025/04/07 06:21:57 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir3"(0)|folder|ITEM_CREATE|315449415758|3a2257f4ae96aaac2b9ce4decaf27fd32fd008bb] added new path ("dir/subdir3") for notify
2025/04/07 06:21:57 DEBUG : doChangeNotify("dir", 0)
2025/04/07 06:21:57 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/07 06:21:57 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/07 06:21:57 DEBUG : box root 'rclone-test-zupegub5futo': Received 4 events, resulting in 3 paths and 3 notifications
2025/04/07 06:21:57 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491664354")
2025/04/07 06:21:58 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491664627")
2025/04/07 06:21:59 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491665355")
2025/04/07 06:22:00 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491666359")
2025/04/07 06:22:00 DEBUG : box root 'rclone-test-zupegub5futo': ["dir"(0)|folder|ITEM_CREATE|315451124707|3c4b1e678fad793336ccc1355b1b8fd095f057ee] ignored due to duplicate EventID
2025/04/07 06:22:00 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir1"(0)|folder|ITEM_CREATE|315450894646|e2300a9c74ad4b014ec8e986a6df3a24edf60df9] ignored due to duplicate EventID
2025/04/07 06:22:00 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir3"(0)|folder|ITEM_CREATE|315449415758|3a2257f4ae96aaac2b9ce4decaf27fd32fd008bb] ignored due to duplicate EventID
2025/04/07 06:22:01 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491667521")
2025/04/07 06:22:01 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir3"(0)|folder|ITEM_CREATE|315449415758|3a2257f4ae96aaac2b9ce4decaf27fd32fd008bb] ignored due to duplicate EventID
2025/04/07 06:22:01 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir2"(0)|folder|ITEM_CREATE|315450897046|a9215af2e7936ee55391f9cb335bc6a654667332] added new path ("dir/subdir2") for notify
2025/04/07 06:22:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.001_c9yfl3"(0)|file|ITEM_UPLOAD|1826567819020|a4179839caff8171aa2b082121997d64315e1f0f] added new path ("dir/file2.rclone_chunk.001_c9yfl3") for notify
2025/04/07 06:22:01 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/07 06:22:01 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_c9yfl3", 1)
2025/04/07 06:22:01 DEBUG : box root 'rclone-test-zupegub5futo': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/07 06:22:01 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491668360")
2025/04/07 06:22:01 INFO  : dir/file2.rclone_chunk.001_c9yfl3: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/07 06:22:02 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491668625")
2025/04/07 06:22:02 INFO  : dir/file2.rclone_chunk.002_c9yfl3: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/07 06:22:02 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir2"(0)|folder|ITEM_CREATE|315450897046|a9215af2e7936ee55391f9cb335bc6a654667332] ignored due to duplicate EventID
2025/04/07 06:22:02 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.001_c9yfl3"(0)|file|ITEM_UPLOAD|1826567819020|a4179839caff8171aa2b082121997d64315e1f0f] ignored due to duplicate EventID
2025/04/07 06:22:03 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491669371")
2025/04/07 06:22:04 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491670364")
2025/04/07 06:22:05 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491671359")
2025/04/07 06:22:05 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir2"(0)|folder|ITEM_CREATE|315450897046|a9215af2e7936ee55391f9cb335bc6a654667332] ignored due to duplicate EventID
2025/04/07 06:22:05 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.001_c9yfl3"(0)|file|ITEM_UPLOAD|1826567819020|a4179839caff8171aa2b082121997d64315e1f0f] ignored due to duplicate EventID
2025/04/07 06:22:06 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491672348")
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491673349")
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002_c9yfl3"(0)|file|ITEM_UPLOAD|1826577477503|fd1ca7dce9367f26f0f1fddd9e84dd52d1ffd24f] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491674358")
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1826567819020|f363012da4a28559a723ea5916af3a3583326905] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file2"(0)|file|ITEM_UPLOAD|1826570392189|b93bd2961b7309f6a9cf04dfa69e57d5c6ac4d24] ignored due to old SequenceID ('\x00')
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': ["rclone-test-zupegub5futo"(0)|folder|ITEM_CREATE|315448213453|00b942cdce01ecfcf51581388024953c55b99445] new parent not found
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/07 06:22:07 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491674599")
2025/04/07 06:22:08 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491674848")
2025/04/07 06:22:08 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1826567819020|f363012da4a28559a723ea5916af3a3583326905] ignored due to duplicate EventID
2025/04/07 06:22:09 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491675364")
2025/04/07 06:22:09 DEBUG : box root 'rclone-test-zupegub5futo': ["file2"(0)|file|ITEM_UPLOAD|1826570392189|b93bd2961b7309f6a9cf04dfa69e57d5c6ac4d24] ignored due to duplicate EventID
2025/04/07 06:22:10 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491676348")
2025/04/07 06:22:11 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491677411")
2025/04/07 06:22:11 DEBUG : box root 'rclone-test-zupegub5futo': ["rclone-test-zupegub5futo"(0)|folder|ITEM_CREATE|315448213453|00b942cdce01ecfcf51581388024953c55b99445] ignored due to duplicate EventID
2025/04/07 06:22:11 INFO  : dir/file4.rclone_chunk.001_c9ynnz: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/07 06:22:12 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491678360")
2025/04/07 06:22:12 INFO  : dir/file4.rclone_chunk.002_c9ynnz: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/07 06:22:12 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001_c9ynnz"(0)|file|ITEM_UPLOAD|1826568047590|be7948efde3b071e79c2281b2dc4fc9f38dd53f0] added new path ("dir/file4.rclone_chunk.001_c9ynnz") for notify
2025/04/07 06:22:12 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826577477503|9294ab2cd00788fedb8db8a4a8b88c63150739fb] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:12 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002_c9ynnz"(0)|file|ITEM_UPLOAD|1826575604894|cfe3cac378faf939d6b36c2f2510ffcdf373b94e] added new path ("dir/file4.rclone_chunk.002_c9ynnz") for notify
2025/04/07 06:22:12 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_c9ynnz", 1)
2025/04/07 06:22:12 DEBUG : doChangeNotify("dir/file4.rclone_chunk.002_c9ynnz", 1)
2025/04/07 06:22:12 DEBUG : box root 'rclone-test-zupegub5futo': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/07 06:22:12 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491679351")
2025/04/07 06:22:13 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491679600")
2025/04/07 06:22:13 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001_c9ynnz"(0)|file|ITEM_UPLOAD|1826568047590|be7948efde3b071e79c2281b2dc4fc9f38dd53f0] ignored due to duplicate EventID
2025/04/07 06:22:13 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826577477503|9294ab2cd00788fedb8db8a4a8b88c63150739fb] ignored due to duplicate EventID
2025/04/07 06:22:13 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002_c9ynnz"(0)|file|ITEM_UPLOAD|1826575604894|cfe3cac378faf939d6b36c2f2510ffcdf373b94e] ignored due to duplicate EventID
2025/04/07 06:22:14 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491680361")
2025/04/07 06:22:14 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001_c9ynnz"(0)|file|ITEM_UPLOAD|1826568047590|be7948efde3b071e79c2281b2dc4fc9f38dd53f0] ignored due to duplicate EventID
2025/04/07 06:22:15 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491681355")
2025/04/07 06:22:15 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1826577477503|9294ab2cd00788fedb8db8a4a8b88c63150739fb] ignored due to duplicate EventID
2025/04/07 06:22:16 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491682588")
2025/04/07 06:22:16 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002_c9ynnz"(0)|file|ITEM_UPLOAD|1826575604894|cfe3cac378faf939d6b36c2f2510ffcdf373b94e] ignored due to duplicate EventID
2025/04/07 06:22:16 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826568047590|ec714ba380347209c3443a4fc217dd0f3dddef57] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:16 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1826575604894|89f92af2cea857a40a7801e9dfbc3987f53c08b2] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:16 DEBUG : box root 'rclone-test-zupegub5futo': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/07 06:22:16 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491683353")
2025/04/07 06:22:17 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491683608")
2025/04/07 06:22:17 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826568047590|ec714ba380347209c3443a4fc217dd0f3dddef57] ignored due to duplicate EventID
2025/04/07 06:22:17 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1826575604894|89f92af2cea857a40a7801e9dfbc3987f53c08b2] ignored due to duplicate EventID
2025/04/07 06:22:18 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491684372")
2025/04/07 06:22:18 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1826568047590|ec714ba380347209c3443a4fc217dd0f3dddef57] ignored due to duplicate EventID
2025/04/07 06:22:19 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491685360")
2025/04/07 06:22:19 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1826575604894|89f92af2cea857a40a7801e9dfbc3987f53c08b2] ignored due to duplicate EventID
2025/04/07 06:22:20 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491686362")
2025/04/07 06:22:20 INFO  : dir/file3.rclone_chunk.001_c9yxt3: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/07 06:22:21 INFO  : dir/file3.rclone_chunk.002_c9yxt3: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491687357")
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001_c9yxt3"(0)|file|ITEM_UPLOAD|1826576418653|1a54571dccc58bf007f3807fc3976773c4c7b9fd] added new path ("dir/file3.rclone_chunk.001_c9yxt3") for notify
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002_c9yxt3"(0)|file|ITEM_UPLOAD|1826574501052|d298641f5abf691a65af92a47e3ef0c767f316b0] added new path ("dir/file3.rclone_chunk.002_c9yxt3") for notify
2025/04/07 06:22:21 DEBUG : doChangeNotify("dir/file3.rclone_chunk.001_c9yxt3", 1)
2025/04/07 06:22:21 DEBUG : doChangeNotify("dir/file3.rclone_chunk.002_c9yxt3", 1)
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491688436")
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001_c9yxt3"(0)|file|ITEM_UPLOAD|1826576418653|1a54571dccc58bf007f3807fc3976773c4c7b9fd] ignored due to duplicate EventID
2025/04/07 06:22:21 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002_c9yxt3"(0)|file|ITEM_UPLOAD|1826574501052|d298641f5abf691a65af92a47e3ef0c767f316b0] ignored due to duplicate EventID
2025/04/07 06:22:22 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491688722")
2025/04/07 06:22:22 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001_c9yxt3"(0)|file|ITEM_UPLOAD|1826576418653|1a54571dccc58bf007f3807fc3976773c4c7b9fd] ignored due to duplicate EventID
2025/04/07 06:22:22 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002_c9yxt3"(0)|file|ITEM_UPLOAD|1826574501052|d298641f5abf691a65af92a47e3ef0c767f316b0] ignored due to duplicate EventID
2025/04/07 06:22:23 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491689358")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491690362")
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001_c9yxt3"(0)|file|ITEM_UPLOAD|1826576418653|1a54571dccc58bf007f3807fc3976773c4c7b9fd] ignored due to duplicate EventID
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002_c9yxt3"(0)|file|ITEM_UPLOAD|1826574501052|d298641f5abf691a65af92a47e3ef0c767f316b0] ignored due to duplicate EventID
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1826574501052|b7ac88bd3fb47e6b7c2c3641c865681eeac11272] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(0)|file|ITEM_UPLOAD|1826573353363|f16a03d18e0f3f99e47a257d2c9556989eab1d5f] ignored due to old SequenceID ('\x00')
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': Received 4 events, resulting in 0 paths and 0 notifications
2025/04/07 06:22:24 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491691363")
2025/04/07 06:22:25 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491691636")
2025/04/07 06:22:25 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002_c9yxt3"(0)|file|ITEM_UPLOAD|1826574501052|d298641f5abf691a65af92a47e3ef0c767f316b0] ignored due to duplicate EventID
2025/04/07 06:22:26 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491692366")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/07 06:22:27 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491693354")
2025/04/07 06:22:27 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1826574501052|b7ac88bd3fb47e6b7c2c3641c865681eeac11272] ignored due to duplicate EventID
2025/04/07 06:22:27 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(0)|file|ITEM_UPLOAD|1826573353363|f16a03d18e0f3f99e47a257d2c9556989eab1d5f] ignored due to duplicate EventID
2025/04/07 06:22:28 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491694348")
2025/04/07 06:22:28 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(0)|file|ITEM_UPLOAD|1826573353363|f16a03d18e0f3f99e47a257d2c9556989eab1d5f] ignored due to duplicate EventID
2025/04/07 06:22:28 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826576418653|c588a9fe5ea1884f4f57ea05a601c03b567c4556] ignored due to old SequenceID ('\x01')
2025/04/07 06:22:28 DEBUG : box root 'rclone-test-zupegub5futo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/07 06:22:28 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491695359")
2025/04/07 06:22:28 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826576418653|c588a9fe5ea1884f4f57ea05a601c03b567c4556] ignored due to duplicate EventID
2025/04/07 06:22:29 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491695605")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/07 06:22:30 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491696354")
2025/04/07 06:22:31 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491697394")
2025/04/07 06:22:31 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826576418653|c588a9fe5ea1884f4f57ea05a601c03b567c4556] ignored due to duplicate EventID
2025/04/07 06:22:31 DEBUG : box root 'rclone-test-zupegub5futo': ["file3"(0)|file|ITEM_UPLOAD|1826570504469|9a48df0fdf2697a84a4e61da05f22b575703b3d2] ignored due to old SequenceID ('\x00')
2025/04/07 06:22:31 DEBUG : box root 'rclone-test-zupegub5futo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/07 06:22:31 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491698360")
2025/04/07 06:22:32 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491698637")
2025/04/07 06:22:32 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1826576418653|c588a9fe5ea1884f4f57ea05a601c03b567c4556] ignored due to duplicate EventID
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/07 06:22:33 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491699375")
2025/04/07 06:22:34 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491700353")
2025/04/07 06:22:34 DEBUG : box root 'rclone-test-zupegub5futo': ["file3"(0)|file|ITEM_UPLOAD|1826570504469|9a48df0fdf2697a84a4e61da05f22b575703b3d2] ignored due to duplicate EventID
2025/04/07 06:22:35 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491701356")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/07 06:22:36 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491702367")
2025/04/07 06:22:37 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491703355")
2025/04/07 06:22:38 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491704355")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/07 06:22:39 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491705364")
2025/04/07 06:22:40 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491706348")
2025/04/07 06:22:41 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491707364")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/07 06:22:42 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491708351")
2025/04/07 06:22:43 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491709360")
2025/04/07 06:22:44 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491710347")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/07 06:22:45 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491711341")
2025/04/07 06:22:46 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491712352")
2025/04/07 06:22:47 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491713498")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/07 06:22:48 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491714492")
2025/04/07 06:22:49 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491715449")
2025/04/07 06:22:50 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491716384")
    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_c9yfl3:{} dir/file3.rclone_chunk.001_c9yxt3:{} dir/file3.rclone_chunk.002_c9yxt3:{} dir/file4.rclone_chunk.001_c9ynnz:{} dir/file4.rclone_chunk.002_c9ynnz:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/07 06:22:51 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491717373")
2025/04/07 06:22:52 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491718358")
2025/04/07 06:22:53 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491719394")
2025/04/07 06:22:54 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491720354")
2025/04/07 06:22:55 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491721385")
2025/04/07 06:22:56 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491722360")
2025/04/07 06:22:57 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491723356")
2025/04/07 06:22:58 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491724393")
2025/04/07 06:22:59 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491725357")
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491726368")
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1826567819020|30d9b28ee6ffc810d9ae07a91047a451b3995373] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': ["file2"(1)|file|ITEM_TRASH|1826570392189|a33f062f311c3e930a81a26097ef46650dddecb0] added old path ("dir/file2") for notify
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826577477503|60d0bc28db59ebdfa8820ccff56c00e3447bcdf5] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826568047590|3753caf124bd83bfa3057d7f1048a618310693ff] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(1)|file|ITEM_TRASH|1826573353363|2f09278dc3268c6b6b0182dc79d14b65a9435adc] added old path ("dir/file4") for notify
2025/04/07 06:23:00 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/07 06:23:00 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/07 06:23:00 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/07 06:23:00 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/07 06:23:00 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': Received 5 events, resulting in 5 paths and 5 notifications
2025/04/07 06:23:00 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491727408")
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826577477503|60d0bc28db59ebdfa8820ccff56c00e3447bcdf5] ignored due to duplicate EventID
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826568047590|3753caf124bd83bfa3057d7f1048a618310693ff] ignored due to duplicate EventID
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(1)|file|ITEM_TRASH|1826573353363|2f09278dc3268c6b6b0182dc79d14b65a9435adc] ignored due to duplicate EventID
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491727816")
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826577477503|60d0bc28db59ebdfa8820ccff56c00e3447bcdf5] ignored due to duplicate EventID
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826568047590|3753caf124bd83bfa3057d7f1048a618310693ff] ignored due to duplicate EventID
2025/04/07 06:23:01 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(1)|file|ITEM_TRASH|1826573353363|2f09278dc3268c6b6b0182dc79d14b65a9435adc] ignored due to duplicate EventID
2025/04/07 06:23:02 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491728447")
2025/04/07 06:23:02 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826577477503|60d0bc28db59ebdfa8820ccff56c00e3447bcdf5] ignored due to duplicate EventID
2025/04/07 06:23:02 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826568047590|3753caf124bd83bfa3057d7f1048a618310693ff] ignored due to duplicate EventID
2025/04/07 06:23:02 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(1)|file|ITEM_TRASH|1826573353363|2f09278dc3268c6b6b0182dc79d14b65a9435adc] ignored due to duplicate EventID
2025/04/07 06:23:03 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491729408")
2025/04/07 06:23:03 DEBUG : box root 'rclone-test-zupegub5futo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1826577477503|60d0bc28db59ebdfa8820ccff56c00e3447bcdf5] ignored due to duplicate EventID
2025/04/07 06:23:04 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491730351")
2025/04/07 06:23:04 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1826568047590|3753caf124bd83bfa3057d7f1048a618310693ff] ignored due to duplicate EventID
2025/04/07 06:23:04 DEBUG : box root 'rclone-test-zupegub5futo': ["file4"(1)|file|ITEM_TRASH|1826573353363|2f09278dc3268c6b6b0182dc79d14b65a9435adc] ignored due to duplicate EventID
2025/04/07 06:23:05 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491731361")
2025/04/07 06:23:06 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491732377")
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491733361")
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file3"(1)|file|ITEM_TRASH|1826570504469|5d8f606423b13cbbf0fb3797cc3cde0dddeb1cd1] old parent not cached
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1826576418653|7a2c921f031259a28b6b92ceb687c651b1f0dff3] old parent not cached
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1826574501052|bdbb931f96245980e2a7610ac4c3a80549dd7402] old parent not cached
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1826575604894|77d0e4e13e62d8e6055697ecaa86e20ab4fdbd95] old parent not cached
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': ["subdir3"(1)|folder|ITEM_TRASH|315449415758|48c8a16f5ecf5604ac6496c974a50dc5f098038d] old parent not cached
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': Received 5 events, resulting in 0 paths and 0 notifications
2025/04/07 06:23:07 DEBUG : box root 'rclone-test-zupegub5futo': Checking for changes on remote (next_stream_position: "30401041491734469")
2025/04/07 06:23:08 DEBUG : box root 'rclone-test-zupegub5futo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/07 06:23:08 ERROR : : error listing: directory not found
2025/04/07 06:23:09 DEBUG : box root 'rclone-test-zupegub5futo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (81.26s)
    --- FAIL: TestIntegration/FsMkdir (77.75s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (75.39s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	81.310s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m23.728412158s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]