"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/11 01:34:07 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-xuluheg9kodi"
2025/04/11 01:34:07 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/11 01:34:07 DEBUG : Creating backend with remote "TestBox:rclone-test-xuluheg9kodi"
2025/04/11 01:34:07 DEBUG : box root 'rclone-test-xuluheg9kodi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/11 01:34:08 DEBUG : box root 'rclone-test-xuluheg9kodi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/11 01:34:09 INFO  : dir: Making directory
2025/04/11 01:34:11 INFO  : dir/subdir1: Making directory
2025/04/11 01:34:12 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041819998016")
2025/04/11 01:34:12 INFO  : dir/subdir3: Making directory
2025/04/11 01:34:13 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041819999263")
2025/04/11 01:34:13 DEBUG : box root 'rclone-test-xuluheg9kodi': ["3"(0)|file|ITEM_UPLOAD|1830729090357|b8e70573aad29616a2d92e3d6c7abaab46dfcef5] new parent not found
2025/04/11 01:34:13 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:13 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820000271")
2025/04/11 01:34:14 INFO  : dir/subdir2: Making directory
2025/04/11 01:34:14 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820000521")
2025/04/11 01:34:14 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:14 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820001255")
2025/04/11 01:34:15 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820001494")
2025/04/11 01:34:15 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:15 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820002253")
2025/04/11 01:34:16 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820002508")
2025/04/11 01:34:17 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820003276")
2025/04/11 01:34:17 DEBUG : box root 'rclone-test-xuluheg9kodi': ["rclone-test-xuluheg9kodi"(0)|folder|ITEM_CREATE|316164292136|840103dbc2280e690736369d66deb48b052431b0] new parent not found
2025/04/11 01:34:17 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:17 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820004302")
2025/04/11 01:34:18 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820004554")
2025/04/11 01:34:19 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820005260")
2025/04/11 01:34:19 DEBUG : box root 'rclone-test-xuluheg9kodi': ["subdir3"(0)|folder|ITEM_CREATE|316163761921|442828998311482ba952451b97da5ec49e3a50dd] added new path ("dir/subdir3") for notify
2025/04/11 01:34:19 DEBUG : box root 'rclone-test-xuluheg9kodi': ["subdir1"(0)|folder|ITEM_CREATE|316164181799|b914210d3e79fbf529e030dc5e73bc8168740b75] added new path ("dir/subdir1") for notify
2025/04/11 01:34:19 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/11 01:34:19 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/11 01:34:19 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/11 01:34:19 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820006250")
2025/04/11 01:34:20 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820006504")
2025/04/11 01:34:20 INFO  : dir/file2.rclone_chunk.001_jbaxhm: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/11 01:34:21 INFO  : dir/file2.rclone_chunk.002_jbaxhm: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/11 01:34:21 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820007294")
2025/04/11 01:34:22 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820008266")
2025/04/11 01:34:22 DEBUG : box root 'rclone-test-xuluheg9kodi': ["subdir2"(0)|folder|ITEM_CREATE|316159247965|323a054744b3ab046fe5276efee304be2309f9a0] added new path ("dir/subdir2") for notify
2025/04/11 01:34:22 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/11 01:34:22 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/11 01:34:22 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820009250")
2025/04/11 01:34:23 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820009502")
2025/04/11 01:34:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820010261")
2025/04/11 01:34:24 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2.rclone_chunk.001_jbaxhm"(0)|file|ITEM_UPLOAD|1830732589673|18a3b475b81a2124f49b0ea7e8d9a0c8da63d364] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820011266")
2025/04/11 01:34:25 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820011511")
2025/04/11 01:34:26 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820012256")
2025/04/11 01:34:26 DEBUG : box root 'rclone-test-xuluheg9kodi': ["dir"(0)|folder|ITEM_CREATE|316159406054|457794790b97fee3fce2ab38ec24c64697f09b94] added new path ("dir") for notify
2025/04/11 01:34:26 DEBUG : doChangeNotify("dir", 0)
2025/04/11 01:34:26 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/11 01:34:26 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820013251")
2025/04/11 01:34:27 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820013535")
2025/04/11 01:34:27 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(1)|file|ITEM_UPLOAD|1830740547976|64156ca1092c4b2adcc3a51257c75b10d06d28ab] new parent not found
2025/04/11 01:34:27 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1830732589673|73572dce2a168e4907d5e700543d234101e49467] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:27 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:27 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820014253")
2025/04/11 01:34:28 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820014502")
2025/04/11 01:34:28 DEBUG : box root 'rclone-test-xuluheg9kodi': ["dst"(0)|folder|ITEM_CREATE|316164291641|da9f1ea4340ec3114f9906dac9331561bcd61b31] new parent not found
2025/04/11 01:34:28 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:28 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820015257")
2025/04/11 01:34:29 INFO  : dir/file4.rclone_chunk.001_jbb613: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/11 01:34:29 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820015498")
2025/04/11 01:34:30 INFO  : dir/file4.rclone_chunk.002_jbb613: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820016259")
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1830731355740|5ffd80a234ed572a5211914df62874827419c176] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820017259")
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2"(0)|file|ITEM_UPLOAD|1830742336554|2580c70947f5fa997d6d93fd8a10643d71e6d7a8] ignored due to old SequenceID ('\x00')
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:30 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820017518")
2025/04/11 01:34:31 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820017764")
2025/04/11 01:34:32 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820018264")
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820019254")
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(0)|file|ITEM_UPLOAD|1830740547976|86f935859bcf77c135add72d65ec0a624050ec4a] new parent not found
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820020253")
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4.rclone_chunk.001_jbb613"(0)|file|ITEM_UPLOAD|1830732578024|9e08484f30c7f1933623245efef0a9065be05e30] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2.rclone_chunk.002_jbaxhm"(0)|file|ITEM_UPLOAD|1830731355740|7658d20703ecd72c0b552774535e6a68cc67b704] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:33 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820020500")
2025/04/11 01:34:34 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820020746")
2025/04/11 01:34:34 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4.rclone_chunk.002_jbb613"(0)|file|ITEM_UPLOAD|1830735488722|77b4f5518aad8ac53152c4fb4f5687785f6bcac2] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:34 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:34 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820021253")
2025/04/11 01:34:35 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820021497")
2025/04/11 01:34:35 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1830732578024|d442d27c5b8c0d45f05be52eb4d5dd56f1640013] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:35 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:35 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820022255")
2025/04/11 01:34:36 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820022503")
2025/04/11 01:34:37 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820023257")
2025/04/11 01:34:37 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(2)|file|ITEM_UPLOAD|1830740547976|c94f3e346c4770407271283743b8601b4e97500f] new parent not found
2025/04/11 01:34:37 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:37 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820024254")
2025/04/11 01:34:38 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820024496")
2025/04/11 01:34:38 INFO  : dir/file3.rclone_chunk.001_jbbflw: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/11 01:34:38 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1830735488722|32a5906699a436bcdf9950b1d0821701b6658618] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:38 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4"(0)|file|ITEM_UPLOAD|1830735913282|98e288e862282e48094a8c4b4f080573c7363b34] ignored due to old SequenceID ('\x00')
2025/04/11 01:34:38 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:38 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820025250")
2025/04/11 01:34:38 INFO  : dir/file3.rclone_chunk.002_jbbflw: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/11 01:34:39 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820025497")
2025/04/11 01:34:40 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820026250")
2025/04/11 01:34:40 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(0)|file|ITEM_UPLOAD|1830739823413|7152fb6c1c15b5ecd51ac1434af0f1e7c64d44f7] new parent not found
2025/04/11 01:34:40 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:40 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820027253")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/11 01:34:41 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820027491")
2025/04/11 01:34:42 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820028251")
2025/04/11 01:34:43 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820029254")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/11 01:34:44 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820030255")
2025/04/11 01:34:45 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820031259")
2025/04/11 01:34:46 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820032257")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820033256")
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file3.rclone_chunk.001_jbbflw"(0)|file|ITEM_UPLOAD|1830738820324|ac8e79c89c0ef8d82fc18762c93531aaf07a79b0] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file3"(0)|file|ITEM_UPLOAD|1830738238928|aff07220e194ec90b16d35183c794ab5e89caefe] ignored due to old SequenceID ('\x00')
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820034247")
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file3.rclone_chunk.002_jbbflw"(0)|file|ITEM_UPLOAD|1830733528236|e9dc371401412687b72ac343e411420dda7509c6] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:47 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820034508")
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1830733528236|62bc78e55590e910aeb3c3e2fa3ef43960589497] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820034754")
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820035000")
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': ["CopyDest"(0)|folder|ITEM_CREATE|316160168486|b52b6331d06b459a1777bb57d7f45162216a4a23] new parent not found
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:48 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820035254")
2025/04/11 01:34:49 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820035496")
2025/04/11 01:34:49 DEBUG : box root 'rclone-test-xuluheg9kodi': ["BackupDir"(0)|folder|ITEM_CREATE|316161087621|9deffedf2ec2e617abdc0d291565ea3f2a4cbfaf] new parent not found
2025/04/11 01:34:49 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1830738820324|c8a29b14739d0bc568df5d1825b5a462c695e3f5] ignored due to old SequenceID ('\x01')
2025/04/11 01:34:49 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:49 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820036249")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/11 01:34:50 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820036510")
2025/04/11 01:34:51 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820037258")
2025/04/11 01:34:52 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820038260")
2025/04/11 01:34:52 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(0)|file|ITEM_COPY|1830732188562|ec489e896d6f2cdd91fd20fe2e93af3a94df177c] new parent not found
2025/04/11 01:34:52 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(3)|file|ITEM_MOVE|1830740547976|04a653cb52d82e4b64e8942cb2d7eb26b7b88055] new parent not found
2025/04/11 01:34:52 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:52 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820039256")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/11 01:34:53 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820039513")
2025/04/11 01:34:54 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820040264")
2025/04/11 01:34:54 DEBUG : box root 'rclone-test-xuluheg9kodi': ["two"(0)|file|ITEM_UPLOAD|1830731454217|19ea99df01854912e48cc12aa637623029065bbb] new parent not found
2025/04/11 01:34:54 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:54 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820041252")
2025/04/11 01:34:55 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820041506")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/11 01:34:56 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820042259")
2025/04/11 01:34:57 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820043248")
2025/04/11 01:34:57 DEBUG : box root 'rclone-test-xuluheg9kodi': ["two"(0)|file|ITEM_COPY|1830734870131|395012e69e3b207b7088ce78a25372f3c26fe677] new parent not found
2025/04/11 01:34:57 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:34:57 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820044257")
2025/04/11 01:34:58 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820044523")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/11 01:34:59 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820045289")
2025/04/11 01:35:00 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820046265")
2025/04/11 01:35:01 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820047299")
2025/04/11 01:35:01 DEBUG : box root 'rclone-test-xuluheg9kodi': ["three"(0)|file|ITEM_UPLOAD|1830740942108|d06767b0669f70ec6769174fba99e8a97a344cd4] new parent not found
2025/04/11 01:35:01 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:01 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820048264")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/11 01:35:02 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820048519")
2025/04/11 01:35:03 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820049255")
2025/04/11 01:35:04 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820050246")
2025/04/11 01:35:04 DEBUG : box root 'rclone-test-xuluheg9kodi': ["three"(0)|file|ITEM_UPLOAD|1830738596689|bb5690659976fcd85a557d30a5512920b5291c30] new parent not found
2025/04/11 01:35:04 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:04 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820051260")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/11 01:35:05 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820051504")
2025/04/11 01:35:06 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820052261")
2025/04/11 01:35:07 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820053255")
2025/04/11 01:35:07 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:07 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820054251")
    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/11 01:35:08 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820054488")
2025/04/11 01:35:08 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:08 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820055279")
2025/04/11 01:35:09 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820055529")
2025/04/11 01:35:09 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:09 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820056256")
2025/04/11 01:35:10 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820056493")
2025/04/11 01:35:11 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820057267")
2025/04/11 01:35:11 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:11 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820058259")
2025/04/11 01:35:11 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:11 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820058505")
2025/04/11 01:35:12 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820058751")
2025/04/11 01:35:13 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820059256")
2025/04/11 01:35:13 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:13 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820060282")
2025/04/11 01:35:14 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820060532")
2025/04/11 01:35:15 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820061257")
2025/04/11 01:35:16 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820062248")
2025/04/11 01:35:16 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:16 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820063251")
2025/04/11 01:35:17 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820063511")
2025/04/11 01:35:17 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2"(1)|file|ITEM_TRASH|1830742336554|b4b2d5da37e7d8b553c32ac48ad7dcb5f2c6d44d] added old path ("dir/file2") for notify
2025/04/11 01:35:17 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1830732589673|2dedb439fbd48a959529eb40e13b6ec5047628db] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/11 01:35:17 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/11 01:35:17 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/11 01:35:17 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/11 01:35:17 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820064255")
2025/04/11 01:35:18 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820064505")
2025/04/11 01:35:19 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820065249")
2025/04/11 01:35:20 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820066259")
2025/04/11 01:35:20 DEBUG : box root 'rclone-test-xuluheg9kodi': ["dst"(0)|folder|ITEM_CREATE|316164335861|4e1f90ad77967b6c7948c85ce64b82ab819a8407] new parent not found
2025/04/11 01:35:20 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4"(1)|file|ITEM_TRASH|1830735913282|a915466d20e129231d6f20b17dbc9102fd9cf9e9] added old path ("dir/file4") for notify
2025/04/11 01:35:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/11 01:35:20 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/11 01:35:20 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820067255")
2025/04/11 01:35:21 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820067495")
2025/04/11 01:35:21 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1830732578024|79e278d8508758418c68ef8a2191af8ea54a2fc2] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/11 01:35:21 DEBUG : box root 'rclone-test-xuluheg9kodi': ["one"(0)|file|ITEM_UPLOAD|1830740982876|b9b98388a192120ef3cc014d16ea9163f44153c9] new parent not found
2025/04/11 01:35:21 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/11 01:35:21 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 3 events, resulting in 1 paths and 1 notifications
2025/04/11 01:35:21 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820068257")
2025/04/11 01:35:22 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820068501")
2025/04/11 01:35:22 DEBUG : box root 'rclone-test-xuluheg9kodi': ["two"(0)|file|ITEM_UPLOAD|1830744205949|31808214ee68bfcbca20a6a07707ce961c2e1386] new parent not found
2025/04/11 01:35:22 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:22 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820069260")
2025/04/11 01:35:23 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820069511")
2025/04/11 01:35:23 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1830735488722|55fe888e1de725b264d50ed35d13eae216f5b4dc] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/11 01:35:23 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/11 01:35:23 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/11 01:35:23 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820070263")
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820070520")
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': ["file3"(1)|file|ITEM_TRASH|1830738238928|7b5c58e7f0c3be0b4407aece26444dc44b2efa92] added old path ("dir/file3") for notify
2025/04/11 01:35:24 DEBUG : doChangeNotify("dir/file3", 1)
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820071247")
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': ["three.txt"(0)|file|ITEM_UPLOAD|1830742921408|eea666258385fb0b821850611062abb36cbb8c32] new parent not found
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/11 01:35:24 DEBUG : box root 'rclone-test-xuluheg9kodi': Checking for changes on remote (next_stream_position: "30401041820071491")
2025/04/11 01:35:26 DEBUG : box root 'rclone-test-xuluheg9kodi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/11 01:35:26 ERROR : : error listing: directory not found
2025/04/11 01:35:26 DEBUG : box root 'rclone-test-xuluheg9kodi': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (79.87s)
    --- FAIL: TestIntegration/FsMkdir (77.32s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (75.01s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	79.920s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m24.259109272s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]