"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/01 09:19:17 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-dojipuk5hibo"
2025/03/01 09:19:17 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/01 09:19:17 DEBUG : Creating backend with remote "TestBox:rclone-test-dojipuk5hibo"
2025/03/01 09:19:18 DEBUG : box root 'rclone-test-dojipuk5hibo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/01 09:19:18 DEBUG : Reset feature "ListR"
2025/03/01 09:19:19 DEBUG : box root 'rclone-test-dojipuk5hibo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/01 09:19:20 INFO  : dir: Making directory
2025/03/01 09:19:21 INFO  : dir/subdir1: Making directory
2025/03/01 09:19:22 INFO  : dir/subdir3: Making directory
2025/03/01 09:19:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305508306")
2025/03/01 09:19:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305509530")
2025/03/01 09:19:23 INFO  : dir/subdir2: Making directory
2025/03/01 09:19:23 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305509754")
2025/03/01 09:19:23 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:23 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305510539")
2025/03/01 09:19:24 DEBUG : box root 'rclone-test-dojipuk5hibo': ["rclone-test-dojipuk5hibo"(0)|folder|ITEM_CREATE|309692821581|21d6379f53dda2a0e40a117bb83ec9fa3e972478] new parent not found
2025/03/01 09:19:24 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:24 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305510764")
2025/03/01 09:19:24 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305510988")
2025/03/01 09:19:25 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305511528")
2025/03/01 09:19:26 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305512528")
2025/03/01 09:19:26 DEBUG : box root 'rclone-test-dojipuk5hibo': ["rclone-test-dojipuk5hibo"(0)|folder|ITEM_CREATE|309692821581|21d6379f53dda2a0e40a117bb83ec9fa3e972478] ignored due to duplicate EventID
2025/03/01 09:19:27 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305513529")
2025/03/01 09:19:28 INFO  : dir/file2.rclone_chunk.001_fzhs5t: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305514534")
2025/03/01 09:19:28 INFO  : dir/file2.rclone_chunk.002_fzhs5t: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': ["dir"(0)|folder|ITEM_CREATE|309694706338|2923124d7f79e3b8220ab08a85d043f02f070c66] added new path ("dir") for notify
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir1"(0)|folder|ITEM_CREATE|309695109572|346c59909312d5f2c63dec6983bb82cedfc28bfa] added new path ("dir/subdir1") for notify
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir3"(0)|folder|ITEM_CREATE|309695096951|98c9d11eb6009a58382c720f30c7f0490f9b94ff] added new path ("dir/subdir3") for notify
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir2"(0)|folder|ITEM_CREATE|309696397962|00a422128a7c1eca9ce48d3a2673b258d2334353] added new path ("dir/subdir2") for notify
2025/03/01 09:19:28 DEBUG : doChangeNotify("dir", 0)
2025/03/01 09:19:28 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/01 09:19:28 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/01 09:19:28 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 6 events, resulting in 4 paths and 4 notifications
2025/03/01 09:19:28 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305515537")
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["dir"(0)|folder|ITEM_CREATE|309694706338|2923124d7f79e3b8220ab08a85d043f02f070c66] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir1"(0)|folder|ITEM_CREATE|309695109572|346c59909312d5f2c63dec6983bb82cedfc28bfa] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["rclone-test-yipoqas1ziko"(3)|folder|ITEM_TRASH|309693812842|ae98f88cd95e6187b36c3d329da61bb1f0b41e8a] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir3"(0)|folder|ITEM_CREATE|309695096951|98c9d11eb6009a58382c720f30c7f0490f9b94ff] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir2"(0)|folder|ITEM_CREATE|309696397962|00a422128a7c1eca9ce48d3a2673b258d2334353] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001_fzhs5t"(0)|file|ITEM_UPLOAD|1790963714192|e9c4dd7bd6d9abc41906031bbf71df4f94e4dee2] added new path ("dir/file2.rclone_chunk.001_fzhs5t") for notify
2025/03/01 09:19:29 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_fzhs5t", 1)
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 6 events, resulting in 1 paths and 1 notifications
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305515775")
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["dir"(0)|folder|ITEM_CREATE|309694706338|2923124d7f79e3b8220ab08a85d043f02f070c66] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir1"(0)|folder|ITEM_CREATE|309695109572|346c59909312d5f2c63dec6983bb82cedfc28bfa] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["rclone-test-yipoqas1ziko"(3)|folder|ITEM_TRASH|309693812842|ae98f88cd95e6187b36c3d329da61bb1f0b41e8a] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir3"(0)|folder|ITEM_CREATE|309695096951|98c9d11eb6009a58382c720f30c7f0490f9b94ff] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir2"(0)|folder|ITEM_CREATE|309696397962|00a422128a7c1eca9ce48d3a2673b258d2334353] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001_fzhs5t"(0)|file|ITEM_UPLOAD|1790963714192|e9c4dd7bd6d9abc41906031bbf71df4f94e4dee2] ignored due to duplicate EventID
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305516034")
2025/03/01 09:19:29 DEBUG : box root 'rclone-test-dojipuk5hibo': ["dir"(0)|folder|ITEM_CREATE|309694706338|2923124d7f79e3b8220ab08a85d043f02f070c66] ignored due to duplicate EventID
2025/03/01 09:19:30 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305516536")
2025/03/01 09:19:30 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir1"(0)|folder|ITEM_CREATE|309695109572|346c59909312d5f2c63dec6983bb82cedfc28bfa] ignored due to duplicate EventID
2025/03/01 09:19:30 DEBUG : box root 'rclone-test-dojipuk5hibo': ["rclone-test-yipoqas1ziko"(3)|folder|ITEM_TRASH|309693812842|ae98f88cd95e6187b36c3d329da61bb1f0b41e8a] ignored due to duplicate EventID
2025/03/01 09:19:30 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir3"(0)|folder|ITEM_CREATE|309695096951|98c9d11eb6009a58382c720f30c7f0490f9b94ff] ignored due to duplicate EventID
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305517533")
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir2"(0)|folder|ITEM_CREATE|309696397962|00a422128a7c1eca9ce48d3a2673b258d2334353] ignored due to duplicate EventID
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001_fzhs5t"(0)|file|ITEM_UPLOAD|1790963714192|e9c4dd7bd6d9abc41906031bbf71df4f94e4dee2] ignored due to duplicate EventID
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963714192|0f72a8b057e98b2d46be6e1b08cec16ea0da66dd] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002_fzhs5t"(0)|file|ITEM_UPLOAD|1790972181240|2c3eccb4c86abcb6e3b380173f13f8b8a5cc5449] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1790972181240|518d3a829f1b1b3dbf943ec8453bb9e0109f2c9b] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:31 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305518532")
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir2"(0)|folder|ITEM_CREATE|309696397962|00a422128a7c1eca9ce48d3a2673b258d2334353] ignored due to duplicate EventID
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001_fzhs5t"(0)|file|ITEM_UPLOAD|1790963714192|e9c4dd7bd6d9abc41906031bbf71df4f94e4dee2] ignored due to duplicate EventID
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963714192|0f72a8b057e98b2d46be6e1b08cec16ea0da66dd] ignored due to duplicate EventID
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002_fzhs5t"(0)|file|ITEM_UPLOAD|1790972181240|2c3eccb4c86abcb6e3b380173f13f8b8a5cc5449] ignored due to duplicate EventID
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1790972181240|518d3a829f1b1b3dbf943ec8453bb9e0109f2c9b] ignored due to duplicate EventID
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305518767")
2025/03/01 09:19:32 DEBUG : box root 'rclone-test-dojipuk5hibo': ["subdir2"(0)|folder|ITEM_CREATE|309696397962|00a422128a7c1eca9ce48d3a2673b258d2334353] ignored due to duplicate EventID
2025/03/01 09:19:33 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305519532")
2025/03/01 09:19:33 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001_fzhs5t"(0)|file|ITEM_UPLOAD|1790963714192|e9c4dd7bd6d9abc41906031bbf71df4f94e4dee2] ignored due to duplicate EventID
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305520529")
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963714192|0f72a8b057e98b2d46be6e1b08cec16ea0da66dd] ignored due to duplicate EventID
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002_fzhs5t"(0)|file|ITEM_UPLOAD|1790972181240|2c3eccb4c86abcb6e3b380173f13f8b8a5cc5449] ignored due to duplicate EventID
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1790972181240|518d3a829f1b1b3dbf943ec8453bb9e0109f2c9b] ignored due to duplicate EventID
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2"(0)|file|ITEM_UPLOAD|1790961402437|9813513e98f80fa3337a973e4599c4645ffad8d9] ignored due to old SequenceID ('\x00')
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:34 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305521529")
2025/03/01 09:19:35 INFO  : dir/file4.rclone_chunk.001_fzhz7n: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/01 09:19:35 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305521770")
2025/03/01 09:19:35 INFO  : dir/file4.rclone_chunk.002_fzhz7n: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/01 09:19:35 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1790972181240|518d3a829f1b1b3dbf943ec8453bb9e0109f2c9b] ignored due to duplicate EventID
2025/03/01 09:19:36 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305522526")
2025/03/01 09:19:36 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2"(0)|file|ITEM_UPLOAD|1790961402437|9813513e98f80fa3337a973e4599c4645ffad8d9] ignored due to duplicate EventID
2025/03/01 09:19:36 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001_fzhz7n"(0)|file|ITEM_UPLOAD|1790966836354|d5615cb6ba20a40861a70b7220ce37595564f351] added new path ("dir/file4.rclone_chunk.001_fzhz7n") for notify
2025/03/01 09:19:36 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_fzhz7n", 1)
2025/03/01 09:19:36 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 2 events, resulting in 1 paths and 1 notifications
2025/03/01 09:19:36 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305523528")
2025/03/01 09:19:37 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305523755")
2025/03/01 09:19:37 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2"(0)|file|ITEM_UPLOAD|1790961402437|9813513e98f80fa3337a973e4599c4645ffad8d9] ignored due to duplicate EventID
2025/03/01 09:19:38 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305524532")
2025/03/01 09:19:39 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305525530")
2025/03/01 09:19:40 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305526532")
2025/03/01 09:19:40 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001_fzhz7n"(0)|file|ITEM_UPLOAD|1790966836354|d5615cb6ba20a40861a70b7220ce37595564f351] ignored due to duplicate EventID
2025/03/01 09:19:41 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305527534")
2025/03/01 09:19:41 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.002_fzhz7n"(0)|file|ITEM_UPLOAD|1790966336794|5089dd9d7cc10cafe79e1a726fe2148f0422d139] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:41 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4"(0)|file|ITEM_UPLOAD|1790963085286|948ca1011aa65ff38e3801aae3bc6c849520f06a] ignored due to old SequenceID ('\x00')
2025/03/01 09:19:41 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:41 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305528528")
2025/03/01 09:19:42 INFO  : dir/file3.rclone_chunk.001_fzi6q0: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/01 09:19:42 INFO  : dir/file3.rclone_chunk.002_fzi6q0: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/01 09:19:42 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305528760")
2025/03/01 09:19:43 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305529528")
2025/03/01 09:19:44 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305530528")
2025/03/01 09:19:44 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4"(0)|file|ITEM_UPLOAD|1790963085286|948ca1011aa65ff38e3801aae3bc6c849520f06a] ignored due to duplicate EventID
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/01 09:19:45 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305531532")
2025/03/01 09:19:46 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305532530")
2025/03/01 09:19:46 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.001_fzi6q0"(0)|file|ITEM_UPLOAD|1790963387576|54b9454144cab823e50d7899793e98571a989a10] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:46 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:46 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305533530")
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1790971450802|b363292731f56e804ac1f49adf7551a066a590ee] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963387576|e92f7d19ab141fea66d4200283b50a153991e604] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002_fzi6q0"(0)|file|ITEM_UPLOAD|1790971450802|f6e72dafa4beff0e2df9fe4c2425e9922b76d5f8] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1790966836354|24474217572de90f9be0fc285f159bb2db23c9a1] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305533756")
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305533996")
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1790971450802|b363292731f56e804ac1f49adf7551a066a590ee] ignored due to duplicate EventID
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963387576|e92f7d19ab141fea66d4200283b50a153991e604] ignored due to duplicate EventID
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002_fzi6q0"(0)|file|ITEM_UPLOAD|1790971450802|f6e72dafa4beff0e2df9fe4c2425e9922b76d5f8] ignored due to duplicate EventID
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1790966836354|24474217572de90f9be0fc285f159bb2db23c9a1] ignored due to duplicate EventID
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3"(0)|file|ITEM_UPLOAD|1790966394394|4de7a4f97a9bad147b15141ba84805617e63f475] ignored due to old SequenceID ('\x00')
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:47 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305534530")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/01 09:19:48 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305534763")
2025/03/01 09:19:48 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1790971450802|b363292731f56e804ac1f49adf7551a066a590ee] ignored due to duplicate EventID
2025/03/01 09:19:48 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963387576|e92f7d19ab141fea66d4200283b50a153991e604] ignored due to duplicate EventID
2025/03/01 09:19:48 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002_fzi6q0"(0)|file|ITEM_UPLOAD|1790971450802|f6e72dafa4beff0e2df9fe4c2425e9922b76d5f8] ignored due to duplicate EventID
2025/03/01 09:19:48 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1790966836354|24474217572de90f9be0fc285f159bb2db23c9a1] ignored due to duplicate EventID
2025/03/01 09:19:48 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3"(0)|file|ITEM_UPLOAD|1790966394394|4de7a4f97a9bad147b15141ba84805617e63f475] ignored due to duplicate EventID
2025/03/01 09:19:49 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305535526")
2025/03/01 09:19:49 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1790971450802|b363292731f56e804ac1f49adf7551a066a590ee] ignored due to duplicate EventID
2025/03/01 09:19:49 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1790963387576|e92f7d19ab141fea66d4200283b50a153991e604] ignored due to duplicate EventID
2025/03/01 09:19:49 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3.rclone_chunk.002_fzi6q0"(0)|file|ITEM_UPLOAD|1790971450802|f6e72dafa4beff0e2df9fe4c2425e9922b76d5f8] ignored due to duplicate EventID
2025/03/01 09:19:50 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305536527")
2025/03/01 09:19:50 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1790966836354|24474217572de90f9be0fc285f159bb2db23c9a1] ignored due to duplicate EventID
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/01 09:19:51 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305537528")
2025/03/01 09:19:51 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file3"(0)|file|ITEM_UPLOAD|1790966394394|4de7a4f97a9bad147b15141ba84805617e63f475] ignored due to duplicate EventID
2025/03/01 09:19:52 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305538527")
2025/03/01 09:19:53 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305539538")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/01 09:19:54 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305540531")
2025/03/01 09:19:55 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305541529")
2025/03/01 09:19:56 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305542530")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/01 09:19:57 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305543531")
2025/03/01 09:19:58 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305544529")
2025/03/01 09:19:58 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1790966336794|49b7ec0ca7acfbbff805c33b44af087e8d2be7c6] ignored due to old SequenceID ('\x01')
2025/03/01 09:19:58 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/01 09:19:58 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305545526")
2025/03/01 09:19:59 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1790966336794|49b7ec0ca7acfbbff805c33b44af087e8d2be7c6] ignored due to duplicate EventID
2025/03/01 09:19:59 DEBUG : box root 'rclone-test-dojipuk5hibo': ["z.txt.rclone_chunk.001"(4)|file|ITEM_TRASH|1790963452796|dffe7295a34aab6d3bcd106022dbd1c9b6913bc6] ignored due to duplicate EventID
2025/03/01 09:19:59 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305545754")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/01 09:20:00 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305546529")
2025/03/01 09:20:01 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305547527")
2025/03/01 09:20:02 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305548527")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/01 09:20:03 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305549528")
2025/03/01 09:20:04 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305550528")
2025/03/01 09:20:05 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305551527")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/01 09:20:06 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305552531")
2025/03/01 09:20:07 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305553530")
2025/03/01 09:20:08 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305554530")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/01 09:20:09 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305555533")
2025/03/01 09:20:10 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305556532")
2025/03/01 09:20:11 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305557530")
    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_fzhs5t:{} dir/file4.rclone_chunk.001_fzhz7n:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/01 09:20:12 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305558527")
2025/03/01 09:20:13 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305559531")
2025/03/01 09:20:14 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305560530")
2025/03/01 09:20:15 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305561527")
2025/03/01 09:20:16 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305562529")
2025/03/01 09:20:17 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305563526")
2025/03/01 09:20:18 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305564531")
2025/03/01 09:20:19 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305565526")
2025/03/01 09:20:20 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305566528")
2025/03/01 09:20:20 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2"(1)|file|ITEM_TRASH|1790961402437|49dc9d8437bdf267825a17d52e36ab9662ffe55d] added old path ("dir/file2") for notify
2025/03/01 09:20:20 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/01 09:20:20 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/01 09:20:20 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305567528")
2025/03/01 09:20:21 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305567751")
2025/03/01 09:20:21 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1790972181240|cb63d1a35625465f42a36fcad6fc922e2fbb4fe6] added old path ("dir/file2.rclone_chunk.002") for notify
2025/03/01 09:20:21 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/01 09:20:21 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/01 09:20:21 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305568533")
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1790963714192|4b29824ac5caed6a2b3c4ea24936737419b7459c] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/01 09:20:22 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 1 events, resulting in 1 paths and 1 notifications
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305568756")
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4"(1)|file|ITEM_TRASH|1790963085286|57df9b044bc04b7746f9837b23066661581bb0e8] added old path ("dir/file4") for notify
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1790966836354|354ad1845e09f50a0c9655ea96951e3573541621] added old path ("dir/file4.rclone_chunk.001") for notify
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1790966336794|d14c18d2685b4c45c1dbba305043d3a5d5d03121] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/01 09:20:22 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/01 09:20:22 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/01 09:20:22 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Received 3 events, resulting in 3 paths and 3 notifications
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305568977")
2025/03/01 09:20:22 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305569205")
2025/03/01 09:20:23 DEBUG : box root 'rclone-test-dojipuk5hibo': Checking for changes on remote (next_stream_position: "30401038305569529")
2025/03/01 09:20:23 DEBUG : box root 'rclone-test-dojipuk5hibo': ["file4"(1)|file|ITEM_TRASH|1790963085286|57df9b044bc04b7746f9837b23066661581bb0e8] ignored due to duplicate EventID
2025/03/01 09:20:25 DEBUG : box root 'rclone-test-dojipuk5hibo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/01 09:20:25 ERROR : : error listing: directory not found
2025/03/01 09:20:25 DEBUG : box root 'rclone-test-dojipuk5hibo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (67.95s)
    --- FAIL: TestIntegration/FsMkdir (65.76s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (63.77s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	67.971s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m10.784106839s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]