"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 4/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/13 05:59:03 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-kokuxug9powo"
2025/05/13 05:59:03 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/13 05:59:03 DEBUG : Creating backend with remote "TestBox:rclone-test-kokuxug9powo"
2025/05/13 05:59:05 DEBUG : box root 'rclone-test-kokuxug9powo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/13 05:59:06 DEBUG : box root 'rclone-test-kokuxug9powo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/13 05:59:09 INFO  : dir: Making directory
2025/05/13 05:59:10 INFO  : dir/subdir1: Making directory
2025/05/13 05:59:11 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600697084")
2025/05/13 05:59:11 INFO  : dir/subdir3: Making directory
2025/05/13 05:59:12 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600698837")
2025/05/13 05:59:12 INFO  : dir/subdir2: Making directory
2025/05/13 05:59:13 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600699316")
2025/05/13 05:59:14 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600700847")
2025/05/13 05:59:14 DEBUG : box root 'rclone-test-kokuxug9powo': ["rclone-test-kokuxug9powo"(0)|folder|ITEM_CREATE|320961130861|d22dbe692943cb94682fc012e4027894bcbf454e] new parent not found
2025/05/13 05:59:14 DEBUG : box root 'rclone-test-kokuxug9powo': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:14 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600701317")
2025/05/13 05:59:15 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600701568")
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600702319")
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': ["file1.txt.rclone_chunk.001_6wwqb4"(0)|file|ITEM_UPLOAD|1860715549962|d4b4814b1fb2372c77a46539ef745cd9d3133e5e] new parent not found
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600703315")
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': ["dir"(0)|folder|ITEM_CREATE|320960205194|3a18b0b48a8fd287dd74ba1bccf6f301a1beba5e] added new path ("dir") for notify
2025/05/13 05:59:16 DEBUG : doChangeNotify("dir", 0)
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 05:59:16 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600703559")
2025/05/13 05:59:17 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600703794")
2025/05/13 05:59:17 DEBUG : box root 'rclone-test-kokuxug9powo': ["subdir1"(0)|folder|ITEM_CREATE|320961203768|415ba9a6d5ef1c1ddc549425c39805e3640b5768] added new path ("dir/subdir1") for notify
2025/05/13 05:59:17 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/13 05:59:17 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 05:59:17 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600704319")
2025/05/13 05:59:17 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:17 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600704553")
2025/05/13 05:59:18 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600704794")
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600705319")
2025/05/13 05:59:19 INFO  : dir/file2.rclone_chunk.001_6wwz1r: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': ["modtime_write_test.rclone_chunk.001_6wwwzx"(0)|file|ITEM_UPLOAD|1860743125395|ba2f75729ca174ad5395ebc4fc440afd755383de] new parent not found
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600706320")
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': ["subdir3"(0)|folder|ITEM_CREATE|320958887932|fe91f559d4f4f1cab83b59bf397f9e86a02d8f20] added new path ("dir/subdir3") for notify
2025/05/13 05:59:19 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 05:59:19 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600706559")
2025/05/13 05:59:19 INFO  : dir/file2.rclone_chunk.002_6wwz1r: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/13 05:59:20 DEBUG : box root 'rclone-test-kokuxug9powo': ["file1.txt"(1)|file|ITEM_RENAME|1860715549962|844b1cd75f3f3caa4cff21f4505e1f63625f17e3] new parent not found
2025/05/13 05:59:20 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:20 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600706804")
2025/05/13 05:59:20 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600707038")
2025/05/13 05:59:21 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600707324")
2025/05/13 05:59:21 DEBUG : box root 'rclone-test-kokuxug9powo': ["modtime_write_test"(1)|file|ITEM_RENAME|1860743125395|832de8c1c4318d42c704c8f6e2d773062cd11b61] new parent not found
2025/05/13 05:59:21 DEBUG : box root 'rclone-test-kokuxug9powo': ["subdir2"(0)|folder|ITEM_CREATE|320961354426|8dbc33c264ee4f3f7f7e7fdaeb42a642798e3d2f] added new path ("dir/subdir2") for notify
2025/05/13 05:59:21 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/13 05:59:21 DEBUG : box root 'rclone-test-kokuxug9powo': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/13 05:59:21 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600708330")
2025/05/13 05:59:22 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600708588")
2025/05/13 05:59:22 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.rclone_chunk.001_6wwz1r"(0)|file|ITEM_UPLOAD|1860717340210|cc96ae703214dad87ed1aff32867868f9dfa55bf] added new path ("dir/file2.rclone_chunk.001_6wwz1r") for notify
2025/05/13 05:59:22 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_6wwz1r", 1)
2025/05/13 05:59:22 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 05:59:22 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600709320")
2025/05/13 05:59:23 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600709577")
2025/05/13 05:59:24 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600710320")
2025/05/13 05:59:24 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.rclone_chunk.002_6wwz1r"(0)|file|ITEM_UPLOAD|1860735154851|4caa5c23ecda4536fab8fa834106cf5b21e08d1f] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:24 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:24 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600711329")
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600711560")
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1860717340210|a12f77f3b5c5d8477a48245785dceb1b0e6018f0] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600712313")
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1860735154851|5e9ce33bde1e003babf253304657385687357878] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:25 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600712549")
2025/05/13 05:59:26 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600712804")
2025/05/13 05:59:27 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600713316")
2025/05/13 05:59:27 INFO  : dir/file4.rclone_chunk.001_6wx6f2: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/13 05:59:27 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:27 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600714326")
2025/05/13 05:59:27 DEBUG : box root 'rclone-test-kokuxug9powo': ["file1.txt.rclone_chunk.001_6wx40u"(0)|file|ITEM_UPLOAD|1860717110000|794f97e6f31538e68d310174fdda4fa00b85b4c8] new parent not found
2025/05/13 05:59:27 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:27 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600714559")
2025/05/13 05:59:28 INFO  : dir/file4.rclone_chunk.002_6wx6f2: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/13 05:59:28 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600714798")
2025/05/13 05:59:29 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600715325")
2025/05/13 05:59:30 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600716325")
2025/05/13 05:59:30 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4.rclone_chunk.001_6wx6f2"(0)|file|ITEM_UPLOAD|1860726136016|4bb4c9868e1699de8976d3f592f2709f923c2523] added new path ("dir/file4.rclone_chunk.001_6wx6f2") for notify
2025/05/13 05:59:30 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_6wx6f2", 1)
2025/05/13 05:59:30 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 05:59:30 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600717313")
2025/05/13 05:59:31 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600717550")
2025/05/13 05:59:31 DEBUG : box root 'rclone-test-kokuxug9powo': ["file1.txt"(1)|file|ITEM_RENAME|1860717110000|d8e93e1e8d10b988834aa768cc9c3cea87aa751a] new parent not found
2025/05/13 05:59:31 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2"(0)|file|ITEM_UPLOAD|1860740768979|7ea8fd3318bb5b7658428e95b687f70b63fb4335] ignored due to old SequenceID ('\x00')
2025/05/13 05:59:31 DEBUG : box root 'rclone-test-kokuxug9powo': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:31 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600718326")
2025/05/13 05:59:32 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600718585")
2025/05/13 05:59:32 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4.rclone_chunk.002_6wx6f2"(0)|file|ITEM_UPLOAD|1860717342785|2e41e0fff920d1f3e7eef5bf05c80177776f5104] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:32 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:32 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600719317")
2025/05/13 05:59:33 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600719560")
2025/05/13 05:59:33 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1860726136016|a2640b38b23a667a9cd457256900920bd68ce188] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:33 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:33 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600720320")
2025/05/13 05:59:34 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600720558")
2025/05/13 05:59:34 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1860717342785|7112c040543a2b1ebe76550508b7b26d95b622ae] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:34 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:34 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600721332")
2025/05/13 05:59:35 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600721577")
2025/05/13 05:59:35 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4"(0)|file|ITEM_UPLOAD|1860727367160|ffdbeaec105449275a04505d7b5a0849089363d8] ignored due to old SequenceID ('\x00')
2025/05/13 05:59:35 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:35 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600722319")
2025/05/13 05:59:35 INFO  : dir/file3.rclone_chunk.001_6wxfzw: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/13 05:59:36 INFO  : dir/file3.rclone_chunk.002_6wxfzw: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/13 05:59:36 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600722556")
2025/05/13 05:59:37 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600723317")
2025/05/13 05:59:37 DEBUG : box root 'rclone-test-kokuxug9powo': ["modtime_write_test.rclone_chunk.001_6wxcjj"(0)|file|ITEM_UPLOAD|1860731694833|79fddcd7346bfafeab486e01b704095352d83ce1] new parent not found
2025/05/13 05:59:37 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:37 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600724318")
2025/05/13 05:59:38 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600724555")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600725316")
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': ["file3.rclone_chunk.001_6wxfzw"(0)|file|ITEM_UPLOAD|1860742897890|451984b36483815eccd1b3207c7ea46a04757e29] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600726317")
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': ["modtime_write_test"(1)|file|ITEM_RENAME|1860731694833|8f72b720a286d0945207c1d287c03cca7f873c7a] new parent not found
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:39 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600726559")
2025/05/13 05:59:40 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:40 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600726802")
2025/05/13 05:59:40 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600727079")
2025/05/13 05:59:41 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600727321")
2025/05/13 05:59:41 DEBUG : box root 'rclone-test-kokuxug9powo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1860742897890|415c7e4ed09d32af734c66889b25677ffa128356] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:41 DEBUG : box root 'rclone-test-kokuxug9powo': ["file3.rclone_chunk.002_6wxfzw"(0)|file|ITEM_UPLOAD|1860716790777|aae5f6f31bef4b5677b49207dce1167af63bc39e] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:41 DEBUG : box root 'rclone-test-kokuxug9powo': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:41 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600728318")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/13 05:59:42 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600728564")
2025/05/13 05:59:42 DEBUG : box root 'rclone-test-kokuxug9powo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1860716790777|2fe7e3838a7314b807af9ba60df2556841cdffaa] ignored due to old SequenceID ('\x01')
2025/05/13 05:59:42 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:42 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600729316")
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600729553")
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.txt.rclone_chunk.001_6wxjaq"(0)|file|ITEM_UPLOAD|1860726635913|1faf1ae114a4b32e31b0b330a4faaa80ab880a8f] new parent not found
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': ["file3"(0)|file|ITEM_UPLOAD|1860730751264|243e8c15ef304caa06696c34eeeae41cea064e10] ignored due to old SequenceID ('\x00')
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600730326")
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': ["file21.txt.rclone_chunk.001_6wxj5s"(0)|file|ITEM_UPLOAD|1860739771011|f8dc6c1de40fa0ffbb524f120001c07dcdf963ee] new parent not found
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:43 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600730569")
2025/05/13 05:59:44 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600730808")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/13 05:59:45 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600731319")
2025/05/13 05:59:46 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600732311")
2025/05/13 05:59:46 DEBUG : box root 'rclone-test-kokuxug9powo': ["file21.txt"(1)|file|ITEM_RENAME|1860739771011|1704a839e76208ddeaebba41f4c646febdcf83b1] new parent not found
2025/05/13 05:59:46 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:46 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600733318")
2025/05/13 05:59:46 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:46 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600733549")
2025/05/13 05:59:47 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600733808")
2025/05/13 05:59:47 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.txt"(1)|file|ITEM_RENAME|1860726635913|6c498328371a88cd8443409126b9c9f4d4699e2e] new parent not found
2025/05/13 05:59:47 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:47 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600734330")
2025/05/13 05:59:47 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:47 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600734586")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/13 05:59:48 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600734827")
2025/05/13 05:59:49 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600735316")
2025/05/13 05:59:49 DEBUG : box root 'rclone-test-kokuxug9powo': ["modtime_write_test.rclone_chunk.001_6wxpyh"(0)|file|ITEM_UPLOAD|1860714088632|3ec934e5bc17f7d9bc65a4cdedbea248d5fa1c46] new parent not found
2025/05/13 05:59:49 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:49 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600736317")
2025/05/13 05:59:50 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600736561")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/13 05:59:51 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600737315")
2025/05/13 05:59:51 DEBUG : box root 'rclone-test-kokuxug9powo': ["modtime_write_test"(1)|file|ITEM_RENAME|1860714088632|9d350ee063ca5b19c470c9ca6d1283432b21519f] new parent not found
2025/05/13 05:59:51 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:51 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600738313")
2025/05/13 05:59:52 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600738550")
2025/05/13 05:59:52 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 05:59:52 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600739313")
2025/05/13 05:59:53 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600739551")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/13 05:59:54 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600740317")
2025/05/13 05:59:55 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600741327")
2025/05/13 05:59:56 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600742314")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/13 05:59:57 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600743317")
2025/05/13 05:59:58 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600744315")
2025/05/13 05:59:59 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600745325")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/13 06:00:00 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600746313")
2025/05/13 06:00:01 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600747368")
2025/05/13 06:00:02 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600748317")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/13 06:00:03 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600749320")
2025/05/13 06:00:04 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600750326")
2025/05/13 06:00:05 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600751315")
    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_6wwz1r:{} dir/file4.rclone_chunk.001_6wx6f2:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/05/13 06:00:06 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600752320")
2025/05/13 06:00:07 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600753316")
2025/05/13 06:00:08 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600754314")
2025/05/13 06:00:09 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600755318")
2025/05/13 06:00:10 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600756316")
2025/05/13 06:00:10 DEBUG : box root 'rclone-test-kokuxug9powo': ["file1.txt.rclone_chunk.001_6wy9ku"(0)|file|ITEM_UPLOAD|1860717364712|835b365f5a0d15073197475d201237f35ceb6ce4] new parent not found
2025/05/13 06:00:10 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 06:00:10 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600757314")
2025/05/13 06:00:11 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600757576")
2025/05/13 06:00:11 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 06:00:11 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600758331")
2025/05/13 06:00:12 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600758574")
2025/05/13 06:00:13 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600759313")
2025/05/13 06:00:14 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600760324")
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600761312")
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1860717340210|7914053e4bbffa35c10df363cc5e9ab69c8ca3e2] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/13 06:00:15 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600762317")
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2"(1)|file|ITEM_TRASH|1860740768979|e9078713d24af67dd0dfd758002c9cf8216ad882] added old path ("dir/file2") for notify
2025/05/13 06:00:15 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 06:00:15 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600762563")
2025/05/13 06:00:16 DEBUG : box root 'rclone-test-kokuxug9powo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1860735154851|ee819ddc06b0079de5b8edb2dcedd405ab030092] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/13 06:00:16 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/13 06:00:16 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/13 06:00:16 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600762810")
2025/05/13 06:00:16 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600763049")
2025/05/13 06:00:17 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600763323")
2025/05/13 06:00:17 DEBUG : box root 'rclone-test-kokuxug9powo': ["file1.txt"(1)|file|ITEM_RENAME|1860717364712|60c99a61abe4296e53cfedade6b6ac615baa54e8] new parent not found
2025/05/13 06:00:17 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 06:00:17 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600764325")
2025/05/13 06:00:18 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600764564")
2025/05/13 06:00:18 DEBUG : box root 'rclone-test-kokuxug9powo': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/13 06:00:18 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600765317")
2025/05/13 06:00:19 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600765563")
2025/05/13 06:00:20 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600766338")
2025/05/13 06:00:20 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1860726136016|411affe9c31a031ebff2595138f17ae5d5deed67] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/13 06:00:20 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4"(1)|file|ITEM_TRASH|1860727367160|6b7f4d91d65e26ae448bbf6353f4495829695c0d] added old path ("dir/file4") for notify
2025/05/13 06:00:20 DEBUG : box root 'rclone-test-kokuxug9powo': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1860717342785|b48ec19ea6138d05a0bc9a260089ddd3b851e9d8] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/13 06:00:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/13 06:00:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/13 06:00:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/13 06:00:20 DEBUG : box root 'rclone-test-kokuxug9powo': Received 3 events, resulting in 3 paths and 3 notifications
2025/05/13 06:00:20 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600767321")
2025/05/13 06:00:21 DEBUG : box root 'rclone-test-kokuxug9powo': Checking for changes on remote (next_stream_position: "30401044600767564")
2025/05/13 06:00:23 DEBUG : box root 'rclone-test-kokuxug9powo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/13 06:00:23 ERROR : : error listing: directory not found
2025/05/13 06:00:23 DEBUG : box root 'rclone-test-kokuxug9powo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (79.90s)
    --- FAIL: TestIntegration/FsMkdir (75.81s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (72.84s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	79.976s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m22.904891141s (try 4/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]