"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 3/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/03 02:44:50 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-ficapeq9rayu"
2025/05/03 02:44:50 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/03 02:44:50 DEBUG : Creating backend with remote "TestBox:rclone-test-ficapeq9rayu"
2025/05/03 02:44:50 DEBUG : box root 'rclone-test-ficapeq9rayu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/03 02:44:51 DEBUG : box root 'rclone-test-ficapeq9rayu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/03 02:44:53 INFO  : dir: Making directory
2025/05/03 02:44:54 INFO  : dir/subdir1: Making directory
2025/05/03 02:44:55 INFO  : dir/subdir3: Making directory
2025/05/03 02:44:55 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725041379")
2025/05/03 02:44:55 DEBUG : box root 'rclone-test-ficapeq9rayu': ["empty space"(0)|file|ITEM_UPLOAD|1851949573694|1b5250bce91dca207c68b9d76782ab794eda05df] new parent not found
2025/05/03 02:44:55 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:55 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725042595")
2025/05/03 02:44:56 INFO  : dir/subdir2: Making directory
2025/05/03 02:44:56 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725042815")
2025/05/03 02:44:57 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725043600")
2025/05/03 02:44:57 DEBUG : box root 'rclone-test-ficapeq9rayu': ["rclone-test-ficapeq9rayu"(0)|folder|ITEM_CREATE|319542429274|2c29678af5e08f89b892c0a56afd718b93b8a141] new parent not found
2025/05/03 02:44:57 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:57 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725044596")
2025/05/03 02:44:58 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725044845")
2025/05/03 02:44:58 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:58 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725045596")
2025/05/03 02:44:59 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725045817")
2025/05/03 02:44:59 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:44:59 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725046596")
2025/05/03 02:45:00 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725046819")
2025/05/03 02:45:00 DEBUG : box root 'rclone-test-ficapeq9rayu': ["dir"(0)|folder|ITEM_CREATE|319543054806|737dade9ba870f3484f44d6a56472c1bd6bce22a] added new path ("dir") for notify
2025/05/03 02:45:00 DEBUG : box root 'rclone-test-ficapeq9rayu': ["potato2"(0)|file|ITEM_UPLOAD|1851950000510|2111b5c9fb6dba3f667d0cc45a87db9be0af140e] new parent not found
2025/05/03 02:45:00 DEBUG : doChangeNotify("dir", 0)
2025/05/03 02:45:00 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/03 02:45:00 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725047594")
2025/05/03 02:45:01 INFO  : dir/file2.rclone_chunk.001_o58y0g: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/03 02:45:01 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725047820")
2025/05/03 02:45:01 DEBUG : box root 'rclone-test-ficapeq9rayu': ["subdir1"(0)|folder|ITEM_CREATE|319543062006|924bf537e4023ea9b79b7aebc116b26fba396c50] added new path ("dir/subdir1") for notify
2025/05/03 02:45:01 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/03 02:45:01 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:45:01 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725048593")
2025/05/03 02:45:01 INFO  : dir/file2.rclone_chunk.002_o58y0g: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/03 02:45:02 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725048811")
2025/05/03 02:45:02 DEBUG : box root 'rclone-test-ficapeq9rayu': ["empty space"(0)|file|ITEM_UPLOAD|1851951957386|bb74fcc83f0fc902ac058df622087b4a89c5bd87] new parent not found
2025/05/03 02:45:02 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:02 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725049594")
2025/05/03 02:45:03 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725049815")
2025/05/03 02:45:03 DEBUG : box root 'rclone-test-ficapeq9rayu': ["sub dir"(0)|folder|ITEM_CREATE|319541773763|751eaeaad6c865bf9099d32b4644cab3f86e206a] new parent not found
2025/05/03 02:45:03 DEBUG : box root 'rclone-test-ficapeq9rayu': ["subdir3"(0)|folder|ITEM_CREATE|319542472681|5d17645f8cf924fd2776bbc66839963bd57fc336] added new path ("dir/subdir3") for notify
2025/05/03 02:45:03 DEBUG : box root 'rclone-test-ficapeq9rayu': ["subdir2"(0)|folder|ITEM_CREATE|319543542430|32cbccdcff8afe40f186aac49973189bf545fc74] added new path ("dir/subdir2") for notify
2025/05/03 02:45:03 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/03 02:45:03 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/03 02:45:03 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 3 events, resulting in 2 paths and 2 notifications
2025/05/03 02:45:03 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725050592")
2025/05/03 02:45:04 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725050822")
2025/05/03 02:45:05 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725051597")
2025/05/03 02:45:05 DEBUG : box root 'rclone-test-ficapeq9rayu': ["potato3"(0)|file|ITEM_UPLOAD|1851949936252|6d713cb642f100eb1cc75979ba910de200a7f97c] new parent not found
2025/05/03 02:45:05 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2.rclone_chunk.001_o58y0g"(0)|file|ITEM_UPLOAD|1851952883163|f4240d5c7bd4f43113b99850a179b6081af63af1] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:05 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:05 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725052595")
2025/05/03 02:45:06 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725052824")
2025/05/03 02:45:06 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2.rclone_chunk.002_o58y0g"(0)|file|ITEM_UPLOAD|1851950677923|e1c6695d6a1dc4c510426d16c4614763a2a21e9e] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:06 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:06 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725053597")
2025/05/03 02:45:07 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725053824")
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1851952883163|ff817a160bc9827b929d379d075208a2ecd02256] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1851950677923|e87cc052b8e95d6c30e93611bde3a042a773e3ef] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 4 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725054597")
2025/05/03 02:45:08 INFO  : dir/file4.rclone_chunk.001_o5952w: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/03 02:45:08 INFO  : dir/file4.rclone_chunk.002_o5952w: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725054979")
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2"(0)|file|ITEM_UPLOAD|1851952947881|c50ece02d63e558e9faf41e1ddbdbfee6eb3e1a1] ignored due to old SequenceID ('\x00')
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:08 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725055593")
2025/05/03 02:45:09 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725055820")
2025/05/03 02:45:09 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:09 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725056601")
2025/05/03 02:45:10 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725056822")
2025/05/03 02:45:10 DEBUG : box root 'rclone-test-ficapeq9rayu': ["small"(0)|file|ITEM_UPLOAD|1851951788722|8cbe541ea327bfabb84ede114657241ae9c6d36c] new parent not found
2025/05/03 02:45:10 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:10 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725057593")
2025/05/03 02:45:11 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725057814")
2025/05/03 02:45:11 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4.rclone_chunk.001_o5952w"(0)|file|ITEM_UPLOAD|1851947795850|dca8a2acf62b42793d603f4e19ae698224078dc9] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:11 DEBUG : box root 'rclone-test-ficapeq9rayu': ["medium"(0)|file|ITEM_UPLOAD|1851949753872|a4809c75c9074afa9f4d3a0125ca3045b9ec7236] new parent not found
2025/05/03 02:45:11 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:11 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725058591")
2025/05/03 02:45:12 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725058831")
2025/05/03 02:45:12 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4.rclone_chunk.002_o5952w"(0)|file|ITEM_UPLOAD|1851951574936|6654f170b4748d1af5cc6ba616766fc406350110] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:12 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:12 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725059594")
2025/05/03 02:45:13 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725059823")
2025/05/03 02:45:14 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725060594")
2025/05/03 02:45:14 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1851947795850|ce05296d1cdcb6f1cf5e68df4d83c9996ab8ce4c] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:14 DEBUG : box root 'rclone-test-ficapeq9rayu': ["large"(0)|file|ITEM_UPLOAD|1851951575178|e9b3c0678ccb028f21bc2c54631bdf1d2aa37128] new parent not found
2025/05/03 02:45:14 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1851951574936|d82c0cb09186e284af3ce29bd2dca48f6f917222] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:14 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:14 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725061607")
2025/05/03 02:45:15 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4"(0)|file|ITEM_UPLOAD|1851952563617|69e2b74818f42879b7caef07c01afebd83a61767] ignored due to old SequenceID ('\x00')
2025/05/03 02:45:15 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:15 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725061834")
2025/05/03 02:45:15 INFO  : dir/file3.rclone_chunk.001_o59cl6: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/03 02:45:15 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725062058")
2025/05/03 02:45:15 INFO  : dir/file3.rclone_chunk.002_o59cl6: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/03 02:45:15 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:15 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725062594")
2025/05/03 02:45:16 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725062821")
2025/05/03 02:45:17 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725063595")
2025/05/03 02:45:17 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:17 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725064603")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/03 02:45:18 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725064826")
2025/05/03 02:45:18 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file3.rclone_chunk.001_o59cl6"(0)|file|ITEM_UPLOAD|1851948275211|e5f42b3e5d08e591a2f2ee8e2d4f9386a10d8f88] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:18 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:18 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725065596")
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': ["small"(0)|file|ITEM_UPLOAD|1851953240830|a79650806ba45f16f01e1660af718a5234d7cbaf] new parent not found
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725065819")
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725066046")
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file3.rclone_chunk.002_o59cl6"(0)|file|ITEM_UPLOAD|1851954550889|b2f5806d8bad9128194bed9ec2c3ea0320dd9337] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:19 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725066596")
2025/05/03 02:45:20 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725066824")
2025/05/03 02:45:20 DEBUG : box root 'rclone-test-ficapeq9rayu': ["medium"(0)|file|ITEM_UPLOAD|1851948731610|fe0d0bde86979e52f4a50f5e0932efe9a5154515] new parent not found
2025/05/03 02:45:20 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:20 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725067595")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/03 02:45:21 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725067820")
2025/05/03 02:45:21 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1851948275211|5fcda5756f68a9eaf1ac45eec3eb52e5db073d02] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:21 DEBUG : box root 'rclone-test-ficapeq9rayu': ["large"(0)|file|ITEM_UPLOAD|1851949254611|c8e52300e1f87a5746fa0fdcef9c2594c85a3a02] new parent not found
2025/05/03 02:45:21 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1851954550889|ddeb09859480f3798f4912c971fa35c17aff5459] ignored due to old SequenceID ('\x01')
2025/05/03 02:45:21 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:21 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725068594")
2025/05/03 02:45:22 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725068824")
2025/05/03 02:45:22 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file3"(0)|file|ITEM_UPLOAD|1851950548397|ab61f2f6b92512772d4289ce27383318ca2c98a4] ignored due to old SequenceID ('\x00')
2025/05/03 02:45:22 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:22 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725069599")
2025/05/03 02:45:23 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:23 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725069831")
2025/05/03 02:45:23 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725070073")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/03 02:45:24 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725070595")
2025/05/03 02:45:24 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:24 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725071594")
2025/05/03 02:45:25 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725071814")
2025/05/03 02:45:26 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725072598")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/03 02:45:27 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725073596")
2025/05/03 02:45:28 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725074595")
2025/05/03 02:45:28 DEBUG : box root 'rclone-test-ficapeq9rayu': ["small"(0)|file|ITEM_UPLOAD|1851951671246|a42cbeeabc12a1652babdebe4e0d355bb4ad0f28] new parent not found
2025/05/03 02:45:28 DEBUG : box root 'rclone-test-ficapeq9rayu': ["medium"(0)|file|ITEM_UPLOAD|1851951109568|ff185b1b6918e33106052943aee0b309a41a57e2] new parent not found
2025/05/03 02:45:28 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:28 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725075598")
2025/05/03 02:45:29 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725075824")
2025/05/03 02:45:29 DEBUG : box root 'rclone-test-ficapeq9rayu': ["large"(0)|file|ITEM_UPLOAD|1851953519120|b77158b504cbb8f92b133d6c9f4b5162ca0571ca] new parent not found
2025/05/03 02:45:29 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:29 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725076594")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/03 02:45:30 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725076821")
2025/05/03 02:45:31 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725077594")
2025/05/03 02:45:31 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:31 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725078594")
2025/05/03 02:45:32 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725078819")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/03 02:45:33 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725079595")
2025/05/03 02:45:33 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:33 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725080594")
2025/05/03 02:45:34 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725080812")
2025/05/03 02:45:34 DEBUG : box root 'rclone-test-ficapeq9rayu': ["small"(0)|file|ITEM_UPLOAD|1851949360758|02db38f963eec4b95037ad268b1f7ed484d88b3d] new parent not found
2025/05/03 02:45:34 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:34 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725081591")
2025/05/03 02:45:35 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725081810")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/03 02:45:36 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725082593")
2025/05/03 02:45:36 DEBUG : box root 'rclone-test-ficapeq9rayu': ["medium"(0)|file|ITEM_UPLOAD|1851951311174|4990bda61f08a36287804f6c6a09266773bbc4aa] new parent not found
2025/05/03 02:45:36 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:36 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725083596")
2025/05/03 02:45:37 DEBUG : box root 'rclone-test-ficapeq9rayu': ["large"(0)|file|ITEM_UPLOAD|1851951481556|d76cd9c0bdbb259107fad47e7ed9fedafa869bbb] new parent not found
2025/05/03 02:45:37 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:37 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725083819")
2025/05/03 02:45:37 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725084037")
2025/05/03 02:45:38 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725084594")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/03 02:45:39 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725085594")
2025/05/03 02:45:39 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:39 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725086596")
2025/05/03 02:45:40 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725086817")
2025/05/03 02:45:40 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:40 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725087598")
2025/05/03 02:45:41 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725087820")
2025/05/03 02:45:41 DEBUG : box root 'rclone-test-ficapeq9rayu': ["ReadFile"(0)|file|ITEM_UPLOAD|1851949000090|dd98b59c04ec2a0fe49c1cd9f0018ec0a1f4aa38] new parent not found
2025/05/03 02:45:41 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:41 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725088595")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/03 02:45:42 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725088825")
2025/05/03 02:45:43 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725089600")
2025/05/03 02:45:44 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725090593")
    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/05/03 02:45:45 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725091595")
2025/05/03 02:45:45 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:45 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725092598")
2025/05/03 02:45:46 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725092853")
2025/05/03 02:45:47 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725093592")
2025/05/03 02:45:47 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file1"(0)|file|ITEM_UPLOAD|1851951211152|a0af535f32aeb5afdc0880d959b5d5decf0fbaaf] new parent not found
2025/05/03 02:45:47 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:47 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725094597")
2025/05/03 02:45:48 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725094826")
2025/05/03 02:45:49 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725095593")
2025/05/03 02:45:49 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2"(0)|file|ITEM_UPLOAD|1851953418430|e5cbd3a408186e29a9a1e0c5ca97998f179579d6] new parent not found
2025/05/03 02:45:49 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:45:49 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725096596")
2025/05/03 02:45:50 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725096817")
2025/05/03 02:45:51 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725097594")
2025/05/03 02:45:52 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725098595")
2025/05/03 02:45:52 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2"(1)|file|ITEM_TRASH|1851952947881|22ce20a10e77f9d27a4e04850704e4a301449ccd] added old path ("dir/file2") for notify
2025/05/03 02:45:52 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:45:52 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:45:52 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725099593")
2025/05/03 02:45:53 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725099816")
2025/05/03 02:45:53 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1851952883163|3e474e3a133a5a2727d568705a8f1b3e294a6a8e] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/03 02:45:53 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:45:53 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:45:53 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725100592")
2025/05/03 02:45:54 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725100814")
2025/05/03 02:45:54 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1851950677923|8b7ae601e8ad3023a73e48fa25ca08dfeea8f53a] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/03 02:45:54 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:45:54 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:45:54 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725101597")
2025/05/03 02:45:55 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725101818")
2025/05/03 02:45:56 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725102591")
2025/05/03 02:45:56 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4"(1)|file|ITEM_TRASH|1851952563617|f0d45299f96168018fbd464830a9d6a2c549914b] added old path ("dir/file4") for notify
2025/05/03 02:45:56 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:45:56 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:45:56 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725103596")
2025/05/03 02:45:57 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725103821")
2025/05/03 02:45:57 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1851951574936|2d7e9fc8858ed80174ee5c426b2e43f8952947d6] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/03 02:45:57 DEBUG : box root 'rclone-test-ficapeq9rayu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1851947795850|95d76fd0e0cef02b28a58e4c64d7f377b337dde5] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/03 02:45:57 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:45:57 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:45:57 DEBUG : box root 'rclone-test-ficapeq9rayu': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/03 02:45:57 DEBUG : box root 'rclone-test-ficapeq9rayu': Checking for changes on remote (next_stream_position: "30401043725104594")
2025/05/03 02:45:59 DEBUG : box root 'rclone-test-ficapeq9rayu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/03 02:45:59 ERROR : : error listing: directory not found
2025/05/03 02:45:59 DEBUG : box root 'rclone-test-ficapeq9rayu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (69.50s)
    --- FAIL: TestIntegration/FsMkdir (66.93s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (64.87s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	69.563s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m12.360514933s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]