"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestChunkerChunk50bBox:"
2025/04/30 21:18:19 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-zigomey2culu"
2025/04/30 21:18:19 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/30 21:18:19 DEBUG : Creating backend with remote "TestBox:rclone-test-zigomey2culu"
2025/04/30 21:18:20 DEBUG : box root 'rclone-test-zigomey2culu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/30 21:18:21 DEBUG : Reset feature "ListR"
2025/04/30 21:18:21 DEBUG : box root 'rclone-test-zigomey2culu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/30 21:18:22 INFO  : dir: Making directory
2025/04/30 21:18:23 INFO  : dir/subdir1: Making directory
2025/04/30 21:18:24 INFO  : dir/subdir3: Making directory
2025/04/30 21:18:24 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532650708")
2025/04/30 21:18:25 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:25 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532651942")
2025/04/30 21:18:25 INFO  : dir/subdir2: Making directory
2025/04/30 21:18:25 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532652169")
2025/04/30 21:18:26 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0sjjy"(0)|file|ITEM_UPLOAD|1849804698235|66775ed3fb129ef628fc2b4e89546fb9ad4d5367] new parent not found
2025/04/30 21:18:26 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:26 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532652931")
2025/04/30 21:18:26 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532653162")
2025/04/30 21:18:27 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532653943")
2025/04/30 21:18:28 DEBUG : box root 'rclone-test-zigomey2culu': ["rclone-test-zigomey2culu"(0)|folder|ITEM_CREATE|319203275913|bbb3f1505aa28d7573a3f41003368f797c527fa3] new parent not found
2025/04/30 21:18:28 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:28 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532654938")
2025/04/30 21:18:28 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532655173")
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': ["dir"(0)|folder|ITEM_CREATE|319203121683|344721302e8678a1d4fe4c0729b95ccce0e6e16f] added new path ("dir") for notify
2025/04/30 21:18:29 DEBUG : doChangeNotify("dir", 0)
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532655939")
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849804698235|496651c9fadf6fa30957769fcbed64704f269dd3] new parent not found
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532656177")
2025/04/30 21:18:29 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532656405")
2025/04/30 21:18:30 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532656937")
2025/04/30 21:18:31 DEBUG : box root 'rclone-test-zigomey2culu': ["subdir1"(0)|folder|ITEM_CREATE|319202231841|de25290c0107c0f7b4562373f1e8f8387a2370e0] added new path ("dir/subdir1") for notify
2025/04/30 21:18:31 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/30 21:18:31 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:18:31 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532657935")
2025/04/30 21:18:31 INFO  : dir/file2.rclone_chunk.001_k0ssre: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/30 21:18:31 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532658165")
2025/04/30 21:18:32 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0spnc"(0)|file|ITEM_UPLOAD|1849803381567|5b5004c854275167868a0c2b554ad45f64929ba7] new parent not found
2025/04/30 21:18:32 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:32 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532658935")
2025/04/30 21:18:32 INFO  : dir/file2.rclone_chunk.002_k0ssre: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/30 21:18:32 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532659170")
2025/04/30 21:18:33 DEBUG : box root 'rclone-test-zigomey2culu': ["subdir3"(0)|folder|ITEM_CREATE|319203069574|37afd89454811a23d4979d0b1d216e7df41a4ec7] added new path ("dir/subdir3") for notify
2025/04/30 21:18:33 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/30 21:18:33 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:18:33 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532659939")
2025/04/30 21:18:33 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532660174")
2025/04/30 21:18:34 DEBUG : box root 'rclone-test-zigomey2culu': ["subdir2"(0)|folder|ITEM_CREATE|319202782856|533147794e93f0df28f4deac3ef3cfbaa98e9498] added new path ("dir/subdir2") for notify
2025/04/30 21:18:34 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/30 21:18:34 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:18:34 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532660937")
2025/04/30 21:18:34 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:34 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532661169")
2025/04/30 21:18:34 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532661400")
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.rclone_chunk.001_k0ssre"(0)|file|ITEM_UPLOAD|1849796284698|8d8079d34605e7afd0cb6b48ac6851f670adaaeb] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532661941")
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849803381567|838d3c3d0f72e199bdcbf372930a3c6f4092a2b6] new parent not found
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532662171")
2025/04/30 21:18:35 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532662402")
2025/04/30 21:18:36 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.rclone_chunk.002_k0ssre"(0)|file|ITEM_UPLOAD|1849794435664|c68331bb5847e0271cc5498e720de9c020a66dfb] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:36 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:36 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532662965")
2025/04/30 21:18:36 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532663194")
2025/04/30 21:18:37 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532663939")
2025/04/30 21:18:38 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test.rclone_chunk.001_k0sucn"(0)|file|ITEM_UPLOAD|1849803225219|69820cb1aa7b7c96eabee4cd3ccf8ebe30d48ec0] new parent not found
2025/04/30 21:18:38 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test"(1)|file|ITEM_RENAME|1849803225219|71ccf387164a31a67ea7393800729f00ac3d6272] new parent not found
2025/04/30 21:18:38 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:38 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532664936")
2025/04/30 21:18:38 INFO  : dir/file4.rclone_chunk.001_k0szsd: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/30 21:18:38 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532665176")
2025/04/30 21:18:39 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1849794435664|d8595e0f0450e204c406ae1a01340c22bc04d3a5] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:39 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1849796284698|75746c6897585bae9cfd021ca0df5a24b7f1a814] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:39 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:39 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532665942")
2025/04/30 21:18:39 INFO  : dir/file4.rclone_chunk.002_k0szsd: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/30 21:18:39 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532666179")
2025/04/30 21:18:40 DEBUG : box root 'rclone-test-zigomey2culu': ["file2"(0)|file|ITEM_UPLOAD|1849795784662|fad7e9be47a5dd8a12e3655949fa2b74e692b9eb] ignored due to old SequenceID ('\x00')
2025/04/30 21:18:40 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:40 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532666936")
2025/04/30 21:18:40 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532667178")
2025/04/30 21:18:41 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532667938")
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0szcf"(0)|file|ITEM_UPLOAD|1849797815164|8157aec69b12dc43a3616b179c831ef353ed1d23] new parent not found
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532668931")
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': ["file4.rclone_chunk.001_k0szsd"(0)|file|ITEM_UPLOAD|1849796795219|23620f80b8b78d185d4397a345017625d54aa37b] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532669173")
2025/04/30 21:18:42 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532669405")
2025/04/30 21:18:43 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532669938")
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': ["file4.rclone_chunk.002_k0szsd"(0)|file|ITEM_UPLOAD|1849793562160|9b415f2b10a53a1c7676642b35f9027165d41632] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532670936")
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1849796795219|68a6a888b8a26c952f6dd5b00cdda7b216fe4b44] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532671163")
2025/04/30 21:18:44 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532671384")
2025/04/30 21:18:45 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849797815164|06cfb84265a3c14bb4a90b2205e72bee16387d10] new parent not found
2025/04/30 21:18:45 DEBUG : box root 'rclone-test-zigomey2culu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1849793562160|2ff5b3d767a66ced6bea7e0241c6603d6b50d606] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:45 DEBUG : box root 'rclone-test-zigomey2culu': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:45 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532671938")
2025/04/30 21:18:45 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532672183")
2025/04/30 21:18:46 INFO  : dir/file3.rclone_chunk.001_k0t7t8: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/30 21:18:46 DEBUG : box root 'rclone-test-zigomey2culu': ["file4"(0)|file|ITEM_UPLOAD|1849796853372|243f008ce6e32e0b7c7355577db2e5d1f8201aac] ignored due to old SequenceID ('\x00')
2025/04/30 21:18:46 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:46 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532672940")
2025/04/30 21:18:46 INFO  : dir/file3.rclone_chunk.002_k0t7t8: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/30 21:18:46 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532673173")
2025/04/30 21:18:47 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532673935")
2025/04/30 21:18:48 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532674937")
    fstests.go:935: Try 1/10 waiting for dirChanges and objChanges
2025/04/30 21:18:49 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0t6f6"(0)|file|ITEM_UPLOAD|1849802504828|d3a1ac3c4bec2fa6fadcfa7b17bc7c2957517af3] new parent not found
2025/04/30 21:18:49 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:49 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532675942")
2025/04/30 21:18:49 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532676178")
2025/04/30 21:18:50 DEBUG : box root 'rclone-test-zigomey2culu': ["file3.rclone_chunk.001_k0t7t8"(0)|file|ITEM_UPLOAD|1849802646896|000dd26b198118f28e43aeecbc476001381bb03f] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:50 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:50 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532676935")
2025/04/30 21:18:50 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532677165")
2025/04/30 21:18:51 DEBUG : box root 'rclone-test-zigomey2culu': ["file3.rclone_chunk.002_k0t7t8"(0)|file|ITEM_UPLOAD|1849793987261|ad8670bb8cfac7338feffb91b6362412e7a41d2b] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:51 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:51 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532677938")
2025/04/30 21:18:51 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532678174")
    fstests.go:935: Try 2/10 waiting for dirChanges and objChanges
2025/04/30 21:18:52 DEBUG : box root 'rclone-test-zigomey2culu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1849802646896|b2278a3a2a11d59469d6526b04a96cc815128883] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:52 DEBUG : box root 'rclone-test-zigomey2culu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1849793987261|7bbd20214fee377cb6b177a5ad9313580eab79bc] ignored due to old SequenceID ('\x01')
2025/04/30 21:18:52 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:52 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532678937")
2025/04/30 21:18:52 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532679176")
2025/04/30 21:18:53 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849802504828|71e4a0e1dd04f0681d286ddd4206531d0b2b0be7] new parent not found
2025/04/30 21:18:53 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:53 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532679939")
2025/04/30 21:18:53 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532680169")
2025/04/30 21:18:54 DEBUG : box root 'rclone-test-zigomey2culu': ["file3"(0)|file|ITEM_UPLOAD|1849796610246|2753f75d8a66340e09bda7419be546bdb7b364de] ignored due to old SequenceID ('\x00')
2025/04/30 21:18:54 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test.rclone_chunk.001_k0tbzd"(0)|file|ITEM_UPLOAD|1849803712364|8e4dde9505723da787538a1cc39a5253e203d4ab] new parent not found
2025/04/30 21:18:54 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:54 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532680934")
2025/04/30 21:18:54 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532681169")
    fstests.go:935: Try 3/10 waiting for dirChanges and objChanges
2025/04/30 21:18:55 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test"(1)|file|ITEM_RENAME|1849803712364|e3ed0a9f4aa5cd761903fe3556b64bc2c905943c] new parent not found
2025/04/30 21:18:55 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:55 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532681933")
2025/04/30 21:18:55 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532682172")
2025/04/30 21:18:56 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:56 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532682950")
2025/04/30 21:18:56 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532683190")
2025/04/30 21:18:57 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532683934")
    fstests.go:935: Try 4/10 waiting for dirChanges and objChanges
2025/04/30 21:18:58 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0tf3p"(0)|file|ITEM_UPLOAD|1849798197112|365b7a794d5ebe1a152e4e36907cf763bce68ed6] new parent not found
2025/04/30 21:18:58 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:18:58 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532684941")
2025/04/30 21:18:58 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532685173")
2025/04/30 21:18:59 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532685936")
2025/04/30 21:19:00 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532686948")
    fstests.go:935: Try 5/10 waiting for dirChanges and objChanges
2025/04/30 21:19:01 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:01 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532687936")
2025/04/30 21:19:01 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532688175")
2025/04/30 21:19:02 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849798197112|66d2e3e2dedc65735eea1145b7746ae53f18daf9] new parent not found
2025/04/30 21:19:02 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:02 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532688946")
2025/04/30 21:19:02 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532689178")
2025/04/30 21:19:03 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532689937")
    fstests.go:935: Try 6/10 waiting for dirChanges and objChanges
2025/04/30 21:19:04 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532690954")
2025/04/30 21:19:05 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532691936")
2025/04/30 21:19:06 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0tmzk"(0)|file|ITEM_UPLOAD|1849796521899|64496c0c93030eb48d3bc01ee04694d31534a111] new parent not found
2025/04/30 21:19:06 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:06 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532692950")
2025/04/30 21:19:06 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532693179")
    fstests.go:935: Try 7/10 waiting for dirChanges and objChanges
2025/04/30 21:19:07 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532693934")
2025/04/30 21:19:08 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849796521899|01fa4cafed2f67c695615d74cb5b6170428f3315] new parent not found
2025/04/30 21:19:08 DEBUG : box root 'rclone-test-zigomey2culu': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:08 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532694942")
2025/04/30 21:19:08 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532695182")
2025/04/30 21:19:09 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532695942")
    fstests.go:935: Try 8/10 waiting for dirChanges and objChanges
2025/04/30 21:19:10 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532696934")
2025/04/30 21:19:11 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test.rclone_chunk.001_k0ts0g"(0)|file|ITEM_UPLOAD|1849795059959|7058984d33d840aee8a43fdcb77e400c9a47165e] new parent not found
2025/04/30 21:19:11 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:11 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532697939")
2025/04/30 21:19:11 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532698176")
2025/04/30 21:19:12 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532698934")
    fstests.go:935: Try 9/10 waiting for dirChanges and objChanges
2025/04/30 21:19:13 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:13 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532699934")
2025/04/30 21:19:13 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test"(1)|file|ITEM_RENAME|1849795059959|f7bd50079f0a3020c82d6f30e259f92627d37dce] new parent not found
2025/04/30 21:19:13 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:13 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532700166")
2025/04/30 21:19:13 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532700396")
2025/04/30 21:19:14 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532700964")
2025/04/30 21:19:15 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532701944")
    fstests.go:939: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/30 21:19:16 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532702936")
2025/04/30 21:19:17 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532703941")
2025/04/30 21:19:18 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532704933")
2025/04/30 21:19:19 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.txt.rclone_chunk.001_k0tz8l"(0)|file|ITEM_UPLOAD|1849796840734|0e4a6fe614377daa1f0f28bec013b89f5dc3fca4] new parent not found
2025/04/30 21:19:19 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:19 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532705946")
2025/04/30 21:19:19 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532706186")
2025/04/30 21:19:20 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532706946")
2025/04/30 21:19:21 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:21 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532707942")
2025/04/30 21:19:21 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.txt"(1)|file|ITEM_RENAME|1849796840734|0efbfb93e3e2e168236fd245df809f13ba484fd4] new parent not found
2025/04/30 21:19:21 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:21 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532708175")
2025/04/30 21:19:21 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532708410")
2025/04/30 21:19:22 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532708934")
2025/04/30 21:19:23 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532709936")
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': ["file2"(1)|file|ITEM_TRASH|1849795784662|0ea2e6bfc082f907bf15ac8fa4599139f8e63ca5] added old path ("dir/file2") for notify
2025/04/30 21:19:24 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532710935")
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt.rclone_chunk.001_k0u5kr"(0)|file|ITEM_UPLOAD|1849804120066|50da57a4ceb5e81c62e1aa11c9d111379c76da67] new parent not found
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532711190")
2025/04/30 21:19:24 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532711424")
2025/04/30 21:19:25 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532711939")
2025/04/30 21:19:26 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532712937")
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1849794435664|81a69f9f58f4976c7499d1141b87381a00e6c62d] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': ["file1.txt"(1)|file|ITEM_RENAME|1849804120066|b511d9c2b8cf9a50b7b1ecb97300ca577c4bca5f] new parent not found
2025/04/30 21:19:27 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': Received 3 events, resulting in 1 paths and 1 notifications
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532713933")
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': ["file4"(1)|file|ITEM_TRASH|1849796853372|ab4bfabecbf7a1b7dc44ca5443399a18a70b1e4d] added old path ("dir/file4") for notify
2025/04/30 21:19:27 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532714171")
2025/04/30 21:19:27 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532714448")
2025/04/30 21:19:28 DEBUG : box root 'rclone-test-zigomey2culu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1849796795219|61a300891b5f87faf65c8fb26536c915bdac2396] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/30 21:19:28 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/30 21:19:28 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:19:28 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532714938")
2025/04/30 21:19:28 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532715166")
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1849793562160|fc53572768449b5fad6b75fef6244fe8f1bbc73e] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/30 21:19:29 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532715932")
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test.rclone_chunk.001_k0uacl"(0)|file|ITEM_UPLOAD|1849804502015|11f211efff4dc5e4fb1b8e4536c11fd5cefddbe0] new parent not found
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532716162")
2025/04/30 21:19:29 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532716386")
2025/04/30 21:19:30 DEBUG : box root 'rclone-test-zigomey2culu': ["modtime_write_test"(1)|file|ITEM_RENAME|1849804502015|1985aa2b0ddc3ddeb30f5465efffdb9213b462af] new parent not found
2025/04/30 21:19:30 DEBUG : box root 'rclone-test-zigomey2culu': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/30 21:19:30 DEBUG : box root 'rclone-test-zigomey2culu': Checking for changes on remote (next_stream_position: "30401043532716933")
2025/04/30 21:19:32 DEBUG : box root 'rclone-test-zigomey2culu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/30 21:19:32 ERROR : : error listing: directory not found
2025/04/30 21:19:32 DEBUG : box root 'rclone-test-zigomey2culu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (72.91s)
    --- FAIL: TestIntegration/FsMkdir (70.16s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (68.08s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	72.949s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m15.354990744s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]