"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/04/23 04:07:46 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-copumeg4cazo"
2025/04/23 04:07:46 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/23 04:07:46 DEBUG : Creating backend with remote "TestBox:rclone-test-copumeg4cazo"
2025/04/23 04:07:46 DEBUG : box root 'rclone-test-copumeg4cazo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/23 04:07:47 DEBUG : box root 'rclone-test-copumeg4cazo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/23 04:07:48 INFO  : dir: Making directory
2025/04/23 04:07:50 INFO  : dir/subdir1: Making directory
2025/04/23 04:07:51 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866017064")
2025/04/23 04:07:51 INFO  : dir/subdir3: Making directory
2025/04/23 04:07:51 DEBUG : box root 'rclone-test-copumeg4cazo': ["only2"(1)|file|ITEM_UPLOAD|1842428281993|3858401a1f971a951aa560e72d7acaae4eb19972] new parent not found
2025/04/23 04:07:51 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:07:51 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866018306")
2025/04/23 04:07:51 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:07:51 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866018560")
2025/04/23 04:07:52 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866018813")
2025/04/23 04:07:52 INFO  : dir/subdir2: Making directory
2025/04/23 04:07:52 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:07:52 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866019297")
2025/04/23 04:07:53 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866019535")
2025/04/23 04:07:54 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866020295")
2025/04/23 04:07:54 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:07:54 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866021299")
2025/04/23 04:07:54 DEBUG : box root 'rclone-test-copumeg4cazo': ["rclone-test-copumeg4cazo"(0)|folder|ITEM_CREATE|318038994398|d50d3ffcbc0182b3f92a7b218b7ead03b145dc5d] new parent not found
2025/04/23 04:07:54 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:07:54 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866021553")
2025/04/23 04:07:55 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:07:55 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866021795")
2025/04/23 04:07:55 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866022035")
2025/04/23 04:07:55 DEBUG : box root 'rclone-test-copumeg4cazo': ["dir"(0)|folder|ITEM_CREATE|318036083091|128af68393d79fb2cb3a4667bb17153c7d131bc5] added new path ("dir") for notify
2025/04/23 04:07:55 DEBUG : doChangeNotify("dir", 0)
2025/04/23 04:07:55 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/23 04:07:55 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866022300")
2025/04/23 04:07:56 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866022541")
2025/04/23 04:07:57 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866023315")
2025/04/23 04:07:58 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866024292")
2025/04/23 04:07:58 DEBUG : box root 'rclone-test-copumeg4cazo': ["subdir3"(0)|folder|ITEM_CREATE|318034905001|f166e4bce9f37ec5f2dc0dec8d3019ad4dc4bac3] added new path ("dir/subdir3") for notify
2025/04/23 04:07:58 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/23 04:07:58 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/23 04:07:58 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866025299")
2025/04/23 04:07:58 INFO  : dir/file2.rclone_chunk.001_5qf7d0: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/23 04:07:59 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866025545")
2025/04/23 04:07:59 INFO  : dir/file2.rclone_chunk.002_5qf7d0: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/23 04:07:59 DEBUG : box root 'rclone-test-copumeg4cazo': ["subdir1"(0)|folder|ITEM_CREATE|318035034031|a9ce8ca8e01bbefa2109877985270e8436c9f0c8] added new path ("dir/subdir1") for notify
2025/04/23 04:07:59 DEBUG : box root 'rclone-test-copumeg4cazo': ["subdir2"(0)|folder|ITEM_CREATE|318035495309|f479a7f4d0d7bdc16c7628b50253a479c37aaa79] added new path ("dir/subdir2") for notify
2025/04/23 04:07:59 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/23 04:07:59 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/23 04:07:59 DEBUG : box root 'rclone-test-copumeg4cazo': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/23 04:07:59 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866026331")
2025/04/23 04:08:00 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866026580")
2025/04/23 04:08:00 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:00 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866027306")
2025/04/23 04:08:01 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866027548")
2025/04/23 04:08:01 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:01 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866028324")
2025/04/23 04:08:01 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:01 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866028566")
2025/04/23 04:08:02 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866028799")
2025/04/23 04:08:02 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2.rclone_chunk.001_5qf7d0"(0)|file|ITEM_UPLOAD|1842432650089|2eb047899d082ef0ce0b9ee42e59f13980f45cf1] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:02 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:02 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866029312")
2025/04/23 04:08:03 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866029561")
2025/04/23 04:08:04 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866030297")
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866031295")
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1842432650089|8c6a4a3dbb3a288c8c36f55cd7ef3314bfd2ee31] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866032298")
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1842437147743|e1ddfa4c0fb6a93be57026c4d46b32e10f2d1a05] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:05 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866032540")
2025/04/23 04:08:06 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:06 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866032775")
2025/04/23 04:08:06 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866033011")
2025/04/23 04:08:06 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:06 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866033294")
2025/04/23 04:08:06 INFO  : dir/file4.rclone_chunk.001_5qffoq: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/23 04:08:07 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866033532")
2025/04/23 04:08:07 INFO  : dir/file4.rclone_chunk.002_5qffoq: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/23 04:08:07 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2"(0)|file|ITEM_UPLOAD|1842441457304|4109279b201bdb088abe7132c75c6b7c1c247e7c] ignored due to old SequenceID ('\x00')
2025/04/23 04:08:07 DEBUG : box root 'rclone-test-copumeg4cazo': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:07 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866034298")
2025/04/23 04:08:08 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866034542")
2025/04/23 04:08:08 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:08 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866035301")
2025/04/23 04:08:09 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866035536")
2025/04/23 04:08:10 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866036297")
2025/04/23 04:08:10 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4.rclone_chunk.001_5qffoq"(0)|file|ITEM_UPLOAD|1842431802688|701337a589016830c7958e13785615df44f32be1] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:10 DEBUG : box root 'rclone-test-copumeg4cazo': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:10 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866037302")
2025/04/23 04:08:11 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866037587")
2025/04/23 04:08:11 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2.rclone_chunk.002_5qf7d0"(0)|file|ITEM_UPLOAD|1842437147743|9736beb1370387fe56ab29ecdba6c28ac0bfaccc] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:11 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:11 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866038296")
2025/04/23 04:08:12 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866038537")
2025/04/23 04:08:12 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4.rclone_chunk.002_5qffoq"(0)|file|ITEM_UPLOAD|1842429566165|1fc0a3b799662d8642939e6acd6d2656b0556f67] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:12 DEBUG : box root 'rclone-test-copumeg4cazo': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:12 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866039305")
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866039547")
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1842431802688|cd620a7b89e467e0ffe2ffaababd602aea8c1490] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866040299")
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1842429566165|0451354e20972ddef9c8b34fab086615d1cb75a2] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:13 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866040546")
2025/04/23 04:08:14 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866040788")
2025/04/23 04:08:14 INFO  : dir/file3.rclone_chunk.001_5qfnel: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/23 04:08:15 INFO  : dir/file3.rclone_chunk.002_5qfnel: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/23 04:08:15 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866041296")
2025/04/23 04:08:15 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4"(0)|file|ITEM_UPLOAD|1842446322575|99d650bdbdc037ea820e3f13c2e0100ef71daf5d] ignored due to old SequenceID ('\x00')
2025/04/23 04:08:15 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:15 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866042303")
2025/04/23 04:08:15 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:15 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866042545")
2025/04/23 04:08:16 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:16 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866042791")
2025/04/23 04:08:16 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866043030")
2025/04/23 04:08:17 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866043295")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/23 04:08:18 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866044309")
2025/04/23 04:08:18 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3.rclone_chunk.001_5qfnel"(0)|file|ITEM_UPLOAD|1842445767810|c42961406c53e671eb61f477c948069be5fac0f3] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:18 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:18 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866045302")
2025/04/23 04:08:18 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:18 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866045551")
2025/04/23 04:08:19 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866045801")
2025/04/23 04:08:19 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:19 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866046298")
2025/04/23 04:08:20 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866046533")
2025/04/23 04:08:20 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3.rclone_chunk.002_5qfnel"(0)|file|ITEM_UPLOAD|1842445557561|d2e9271c37c0c05750d12f2d7993cd4e0e99c514] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:20 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:20 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866047302")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866047548")
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1842445557561|cc26e73a0bcd04c2f7544c45c025709b76ddaa1c] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1842445767810|b44aafe6a43e9e0423cb2e7bcc4a94b1a23ad3bc] ignored due to old SequenceID ('\x01')
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866048304")
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:21 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866048552")
2025/04/23 04:08:22 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866048798")
2025/04/23 04:08:22 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3"(0)|file|ITEM_UPLOAD|1842439203850|5adfe466f3434529ada7380a3cf7e10eaeae5209] ignored due to old SequenceID ('\x00')
2025/04/23 04:08:22 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:22 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866049303")
2025/04/23 04:08:22 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:22 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866049537")
2025/04/23 04:08:23 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866049778")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/23 04:08:24 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866050337")
2025/04/23 04:08:24 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:24 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866051308")
2025/04/23 04:08:25 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866051546")
2025/04/23 04:08:25 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:25 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866052305")
2025/04/23 04:08:26 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866052542")
2025/04/23 04:08:26 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:26 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866053299")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/23 04:08:26 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:26 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866053547")
2025/04/23 04:08:27 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866053782")
2025/04/23 04:08:28 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866054300")
2025/04/23 04:08:28 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:28 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866055298")
2025/04/23 04:08:29 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866055539")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/23 04:08:30 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866056292")
2025/04/23 04:08:30 DEBUG : box root 'rclone-test-copumeg4cazo': ["empty_on_remote"(0)|folder|ITEM_CREATE|318035990083|7408f299fbb7bbe9521e51de4a18066ea9b89675] new parent not found
2025/04/23 04:08:30 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:30 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866057313")
2025/04/23 04:08:31 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866057551")
2025/04/23 04:08:32 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866058306")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/23 04:08:33 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866059303")
2025/04/23 04:08:33 DEBUG : box root 'rclone-test-copumeg4cazo': ["test_dir2"(0)|folder|ITEM_CREATE|318036138585|f46ed5dd8d3307ee17d24685b4b99906705bb285] new parent not found
2025/04/23 04:08:33 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:33 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866060297")
2025/04/23 04:08:34 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866060539")
2025/04/23 04:08:34 DEBUG : box root 'rclone-test-copumeg4cazo': ["sub_dir"(0)|folder|ITEM_CREATE|318035583623|d13848669c741d2e47969b50d1d2b55c6ae8b333] new parent not found
2025/04/23 04:08:34 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:34 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866061308")
2025/04/23 04:08:35 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866061549")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/23 04:08:36 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866062295")
2025/04/23 04:08:36 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3"(0)|file|ITEM_UPLOAD|1842441702984|92b2eed7ade0702ec82c3aedaecd73c43af03e3a] new parent not found
2025/04/23 04:08:36 DEBUG : box root 'rclone-test-copumeg4cazo': ["test_dir1"(0)|folder|ITEM_CREATE|318038840868|677c9a416dab2ed2ba95bb834a687edc4c14f014] new parent not found
2025/04/23 04:08:36 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:36 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866063300")
2025/04/23 04:08:37 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866063539")
2025/04/23 04:08:37 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2"(0)|file|ITEM_UPLOAD|1842430311627|5c00d442c3eeed996110710470ce9f8da6ad47cb] new parent not found
2025/04/23 04:08:37 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:37 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866064306")
2025/04/23 04:08:38 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866064552")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/23 04:08:39 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866065301")
2025/04/23 04:08:39 DEBUG : box root 'rclone-test-copumeg4cazo': ["file1"(0)|file|ITEM_UPLOAD|1842436366954|b21eda6c356ee0515a66af8011045a8bd7154a0a] new parent not found
2025/04/23 04:08:39 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:39 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866066302")
2025/04/23 04:08:40 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866066542")
2025/04/23 04:08:41 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866067299")
2025/04/23 04:08:41 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:41 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866068297")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/23 04:08:42 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866068540")
2025/04/23 04:08:43 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866069298")
2025/04/23 04:08:43 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:43 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866070298")
2025/04/23 04:08:44 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866070535")
2025/04/23 04:08:44 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:44 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866071295")
    fstests.go:935: 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/23 04:08:45 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866071544")
2025/04/23 04:08:45 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:45 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866072299")
2025/04/23 04:08:46 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866072551")
2025/04/23 04:08:47 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866073306")
2025/04/23 04:08:47 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:47 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866074299")
2025/04/23 04:08:48 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866074547")
2025/04/23 04:08:49 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866075293")
2025/04/23 04:08:50 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866076293")
2025/04/23 04:08:50 DEBUG : box root 'rclone-test-copumeg4cazo': ["empty_on_remote"(0)|folder|ITEM_CREATE|318035787818|f9c4ab2146f85724e1a99a445d25550ec610f7f2] new parent not found
2025/04/23 04:08:50 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:50 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866077303")
2025/04/23 04:08:51 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866077549")
2025/04/23 04:08:52 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866078297")
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866079307")
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': ["test_dir2"(0)|folder|ITEM_CREATE|318035082927|ca48d982c1bb3cc4f8a66d9658b35e7b3f3f2ce9] new parent not found
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866080297")
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': ["sub_dir"(0)|folder|ITEM_CREATE|318037038488|022319f08d7e66a1a1b39801bbac612a978fe143] new parent not found
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:53 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866080542")
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866080784")
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': ["file1"(0)|file|ITEM_UPLOAD|1842447580222|21e4fd072cecf1881f9b4a50dadb875b9c42fd3d] new parent not found
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866081306")
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1842437147743|44287bf7dc85b1e8cc03f20800efbb581421451d] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/23 04:08:54 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/23 04:08:54 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866081573")
2025/04/23 04:08:55 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866081812")
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866082298")
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3"(0)|file|ITEM_UPLOAD|1842431583779|5a9935061d4da301da7f5e2ecb4a01f6515a2b92] new parent not found
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2"(0)|file|ITEM_UPLOAD|1842440821790|83a22139e9b24c22ce9dc9b345a4241b106fc348] new parent not found
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866083299")
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4"(1)|file|ITEM_TRASH|1842446322575|220b5e78f50ead8b395f7b3fcc4ca398f043b63d] added old path ("dir/file4") for notify
2025/04/23 04:08:56 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/23 04:08:56 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866083549")
2025/04/23 04:08:57 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866083781")
2025/04/23 04:08:57 DEBUG : box root 'rclone-test-copumeg4cazo': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1842431802688|4cc98592f306df9782305fe1e9f42123da13e034] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/23 04:08:57 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/23 04:08:57 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/23 04:08:57 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866084294")
2025/04/23 04:08:58 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866084533")
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866085292")
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': ["file2"(1)|file|ITEM_TRASH|1842441457304|e46bb07bfd4247625508ea64b42423fcccc45b72] added old path ("dir/file2") for notify
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': ["file3"(1)|file|ITEM_TRASH|1842439203850|f1371df6f35b6240eabb7c61dd3d7ebddada7d37] added old path ("dir/file3") for notify
2025/04/23 04:08:59 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/23 04:08:59 DEBUG : doChangeNotify("dir/file3", 1)
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866086310")
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': ["test_dir1"(0)|folder|ITEM_CREATE|318036971167|c57756065a07035dde5a507c1c4e6d85da411842] new parent not found
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/23 04:08:59 DEBUG : box root 'rclone-test-copumeg4cazo': Checking for changes on remote (next_stream_position: "30401042866086559")
2025/04/23 04:09:01 DEBUG : box root 'rclone-test-copumeg4cazo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/23 04:09:01 ERROR : : error listing: directory not found
2025/04/23 04:09:02 DEBUG : box root 'rclone-test-copumeg4cazo': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (75.97s)
    --- FAIL: TestIntegration/FsMkdir (73.49s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (71.26s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	76.011s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m18.742553066s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]