"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 5/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/05/03 02:47:14 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-rolefuv6qige"
2025/05/03 02:47:14 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/03 02:47:14 DEBUG : Creating backend with remote "TestBox:rclone-test-rolefuv6qige"
2025/05/03 02:47:14 DEBUG : box root 'rclone-test-rolefuv6qige': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/03 02:47:15 DEBUG : box root 'rclone-test-rolefuv6qige': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/03 02:47:16 INFO  : dir: Making directory
2025/05/03 02:47:17 INFO  : dir/subdir1: Making directory
2025/05/03 02:47:18 INFO  : dir/subdir3: Making directory
2025/05/03 02:47:18 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725184382")
2025/05/03 02:47:18 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:18 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725185603")
2025/05/03 02:47:19 INFO  : dir/subdir2: Making directory
2025/05/03 02:47:19 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725185828")
2025/05/03 02:47:20 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725186599")
2025/05/03 02:47:20 DEBUG : box root 'rclone-test-rolefuv6qige': ["sub"(0)|folder|ITEM_CREATE|319541815190|aa3825958b543ab9608599f2ee10f63d3582993e] new parent not found
2025/05/03 02:47:20 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:20 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725187599")
2025/05/03 02:47:21 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725187840")
2025/05/03 02:47:21 DEBUG : box root 'rclone-test-rolefuv6qige': ["rclone-test-rolefuv6qige"(0)|folder|ITEM_CREATE|319543538328|f4fe4dc99db716012fa8ace12e3cbc2d76226601] new parent not found
2025/05/03 02:47:21 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2"(0)|file|ITEM_UPLOAD|1851950156741|7ef7c20b0e5b2345173f037d7081e5569742d5ec] new parent not found
2025/05/03 02:47:21 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:21 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725188599")
2025/05/03 02:47:22 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725188826")
2025/05/03 02:47:23 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725189598")
2025/05/03 02:47:23 DEBUG : box root 'rclone-test-rolefuv6qige': ["dir"(0)|folder|ITEM_CREATE|319543303078|d66c81b2923e9f752a5b58dc04aff2a2f4c16455] added new path ("dir") for notify
2025/05/03 02:47:23 DEBUG : doChangeNotify("dir", 0)
2025/05/03 02:47:23 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:47:23 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725190599")
2025/05/03 02:47:24 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725190821")
2025/05/03 02:47:24 INFO  : dir/file2.rclone_chunk.001_o5cxhn: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/03 02:47:24 DEBUG : box root 'rclone-test-rolefuv6qige': ["subdir1"(0)|folder|ITEM_CREATE|319543573713|4921860e7ee19a233ceb62e76f5229a51d407061] added new path ("dir/subdir1") for notify
2025/05/03 02:47:24 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/03 02:47:24 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:47:24 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725191604")
2025/05/03 02:47:25 INFO  : dir/file2.rclone_chunk.002_o5cxhn: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/03 02:47:25 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725191827")
2025/05/03 02:47:25 DEBUG : box root 'rclone-test-rolefuv6qige': ["subdir3"(0)|folder|ITEM_CREATE|319543827949|83cc5a1ab699c27b47dd7e27ef2a1fabe646b8d1] added new path ("dir/subdir3") for notify
2025/05/03 02:47:25 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/03 02:47:25 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:47:25 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725192602")
2025/05/03 02:47:26 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725192822")
2025/05/03 02:47:26 DEBUG : box root 'rclone-test-rolefuv6qige': ["subdir2"(0)|folder|ITEM_CREATE|319543230328|1cc78974bda157eb2cf79d5d216b50d9d2aeee35] added new path ("dir/subdir2") for notify
2025/05/03 02:47:26 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/03 02:47:26 DEBUG : box root 'rclone-test-rolefuv6qige': Received 3 events, resulting in 1 paths and 1 notifications
2025/05/03 02:47:26 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725193601")
2025/05/03 02:47:27 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725193842")
2025/05/03 02:47:28 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725194598")
2025/05/03 02:47:29 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725195598")
2025/05/03 02:47:29 DEBUG : box root 'rclone-test-rolefuv6qige': ["file1"(0)|file|ITEM_UPLOAD|1851949502373|56595b79e0197b8a8f9c5ed6c525704befc4cf04] new parent not found
2025/05/03 02:47:29 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2.rclone_chunk.001_o5cxhn"(0)|file|ITEM_UPLOAD|1851951042128|7620c3f7d1c790a3145e0de041386afc5e56ba47] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:29 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2.rclone_chunk.002_o5cxhn"(0)|file|ITEM_UPLOAD|1851950229442|b5f305efb851f6db811cf7bad195f52d70259162] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:29 DEBUG : box root 'rclone-test-rolefuv6qige': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:29 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725196600")
2025/05/03 02:47:30 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1851951042128|b2531c296649dd29ba7e79ba55ceff8924007dbf] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:30 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:30 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725196836")
2025/05/03 02:47:30 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725197061")
2025/05/03 02:47:31 INFO  : dir/file4.rclone_chunk.001_o5d4ce: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/03 02:47:31 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725197600")
2025/05/03 02:47:31 INFO  : dir/file4.rclone_chunk.002_o5d4ce: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/03 02:47:31 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1851950229442|7ff1a25f3e00a158a5559354a101ee87d263b3b5] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:31 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:31 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725198599")
2025/05/03 02:47:32 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725198827")
2025/05/03 02:47:32 DEBUG : box root 'rclone-test-rolefuv6qige': ["sub"(0)|folder|ITEM_CREATE|319542159914|913ff5ec557c6b7edaceabc2326177590a2e4faf] new parent not found
2025/05/03 02:47:32 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2"(0)|file|ITEM_UPLOAD|1851951671556|974161f364b09313150d38edacaa8804e3ee6bd1] ignored due to old SequenceID ('\x00')
2025/05/03 02:47:32 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:32 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725199603")
2025/05/03 02:47:33 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725199842")
2025/05/03 02:47:33 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2"(0)|file|ITEM_UPLOAD|1851948651622|ff632556bf92fd5ad6942367b25ede3b298c8ec9] new parent not found
2025/05/03 02:47:33 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:33 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725200596")
2025/05/03 02:47:34 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725200817")
2025/05/03 02:47:35 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725201602")
2025/05/03 02:47:35 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4.rclone_chunk.001_o5d4ce"(0)|file|ITEM_UPLOAD|1851951174586|8ee3db7ef21171047cc365b4658924a1bca0a630] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:35 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:35 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725202598")
2025/05/03 02:47:36 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725202825")
2025/05/03 02:47:36 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4.rclone_chunk.002_o5d4ce"(0)|file|ITEM_UPLOAD|1851951985551|c35db83840385126d22b76cdef3ef9af8b2b7927] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:36 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:36 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725203606")
2025/05/03 02:47:37 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725203827")
2025/05/03 02:47:37 DEBUG : box root 'rclone-test-rolefuv6qige': ["File2-rclone-move-womeney3"(1)|file|ITEM_RENAME|1851948651622|38a379d8833797adc4c55d3e172ae78ff04c854c] new parent not found
2025/05/03 02:47:37 DEBUG : box root 'rclone-test-rolefuv6qige': ["File2"(2)|file|ITEM_RENAME|1851948651622|f0c8500bb7968d5a1ce85989b5fee4670b3d9d46] new parent not found
2025/05/03 02:47:37 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1851951174586|7b558669b49dd07d5879894400e70412243c8c14] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:37 DEBUG : box root 'rclone-test-rolefuv6qige': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:37 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725204602")
2025/05/03 02:47:37 INFO  : dir/file3.rclone_chunk.001_o5dbwj: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/03 02:47:38 INFO  : dir/file3.rclone_chunk.002_o5dbwj: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/03 02:47:38 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725204834")
2025/05/03 02:47:38 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1851951985551|c82a185dd8922a459c9693671877d028d1c019c0] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:38 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:38 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725205599")
2025/05/03 02:47:39 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4"(0)|file|ITEM_UPLOAD|1851954514986|c04854d760d2a2433eb9884e612e75c7807b529f] ignored due to old SequenceID ('\x00')
2025/05/03 02:47:39 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:39 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725205821")
2025/05/03 02:47:39 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725206042")
2025/05/03 02:47:40 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725206599")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/03 02:47:40 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:40 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725207598")
2025/05/03 02:47:41 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:41 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725207817")
2025/05/03 02:47:41 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725208035")
2025/05/03 02:47:41 DEBUG : box root 'rclone-test-rolefuv6qige': ["file3.rclone_chunk.001_o5dbwj"(0)|file|ITEM_UPLOAD|1851951987723|f3186f8d65e7fe4956892f04991c910467139a7c] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:41 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:41 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725208599")
2025/05/03 02:47:42 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725208822")
2025/05/03 02:47:42 DEBUG : box root 'rclone-test-rolefuv6qige': ["file3.rclone_chunk.002_o5dbwj"(0)|file|ITEM_UPLOAD|1851950769356|c04a8d544f104462af0c581d7147595bbb218fad] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:42 DEBUG : box root 'rclone-test-rolefuv6qige': ["hello"(0)|file|ITEM_UPLOAD|1851953442636|302063a40ce2574952cf1e77913dd27ac209ebc9] new parent not found
2025/05/03 02:47:42 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:42 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725209604")
2025/05/03 02:47:43 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725209829")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/03 02:47:43 DEBUG : box root 'rclone-test-rolefuv6qige': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1851950769356|de17b7606229ae937aaeb0020bcd1d93b762c78c] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:43 DEBUG : box root 'rclone-test-rolefuv6qige': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1851951987723|f53ef372aedcba18abf8cfc6f47aa2f4628da7c9] ignored due to old SequenceID ('\x01')
2025/05/03 02:47:43 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:43 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725210599")
2025/05/03 02:47:44 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725210831")
2025/05/03 02:47:45 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725211602")
2025/05/03 02:47:46 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725212601")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/03 02:47:46 DEBUG : box root 'rclone-test-rolefuv6qige': ["file3"(0)|file|ITEM_UPLOAD|1851949597207|83ca52b858b17ed9b343939bb37a5cfec9b996ee] ignored due to old SequenceID ('\x00')
2025/05/03 02:47:46 DEBUG : box root 'rclone-test-rolefuv6qige': ["dst"(0)|folder|ITEM_CREATE|319543609807|6d7cc304ebe43e57afa8a3f7a08fcd5c831452e3] new parent not found
2025/05/03 02:47:46 DEBUG : box root 'rclone-test-rolefuv6qige': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:46 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725213599")
2025/05/03 02:47:47 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725213829")
2025/05/03 02:47:48 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725214601")
2025/05/03 02:47:48 DEBUG : box root 'rclone-test-rolefuv6qige': ["file1"(0)|file|ITEM_UPLOAD|1851950010193|6b3b7d5befbcbc8a6b40910e1370b5f5458a86eb] new parent not found
2025/05/03 02:47:48 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:48 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725215601")
2025/05/03 02:47:49 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725215823")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/03 02:47:50 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725216603")
2025/05/03 02:47:51 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725217604")
2025/05/03 02:47:52 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725218599")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/03 02:47:52 DEBUG : box root 'rclone-test-rolefuv6qige': ["backup"(0)|folder|ITEM_CREATE|319543384010|afad87b138ffabcc719db3048004a8cbfb399f15] new parent not found
2025/05/03 02:47:52 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:52 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725219602")
2025/05/03 02:47:53 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725219827")
2025/05/03 02:47:53 DEBUG : box root 'rclone-test-rolefuv6qige': ["dst"(0)|folder|ITEM_CREATE|319541946810|c0821c68bea955343cd7cb5430aacc2ee0d721aa] new parent not found
2025/05/03 02:47:53 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:53 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725220600")
2025/05/03 02:47:54 DEBUG : box root 'rclone-test-rolefuv6qige': ["file1"(1)|file|ITEM_MOVE|1851950010193|fcd3bf0bb281bef6e2820a8c8e9a10f873c240cf] new parent not found
2025/05/03 02:47:54 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:54 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725220821")
2025/05/03 02:47:54 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725221043")
2025/05/03 02:47:55 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725221598")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/03 02:47:56 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725222601")
2025/05/03 02:47:56 DEBUG : box root 'rclone-test-rolefuv6qige': ["file1"(0)|file|ITEM_UPLOAD|1851949079576|2a7e0602c4081c033c6daa3af4fead2036f446a6] new parent not found
2025/05/03 02:47:56 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:56 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725223599")
2025/05/03 02:47:57 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725223825")
2025/05/03 02:47:58 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725224598")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/03 02:47:58 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:58 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725225596")
2025/05/03 02:47:59 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725225819")
2025/05/03 02:47:59 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:47:59 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725226600")
2025/05/03 02:48:00 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725226826")
2025/05/03 02:48:00 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:00 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725227601")
2025/05/03 02:48:01 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725227827")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/03 02:48:02 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725228600")
2025/05/03 02:48:02 DEBUG : box root 'rclone-test-rolefuv6qige': ["A1"(0)|folder|ITEM_CREATE|319542419778|356af51c031edb8f469aa01fda977c3693bca212] new parent not found
2025/05/03 02:48:02 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:02 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725229601")
2025/05/03 02:48:03 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725229829")
2025/05/03 02:48:03 DEBUG : box root 'rclone-test-rolefuv6qige': ["one"(0)|file|ITEM_UPLOAD|1851950613251|0e3d9b8b6530578b79f0bfd14e07b422824b8cfc] new parent not found
2025/05/03 02:48:03 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:03 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725230599")
2025/05/03 02:48:04 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725230823")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/03 02:48:05 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725231601")
2025/05/03 02:48:05 DEBUG : box root 'rclone-test-rolefuv6qige': ["two"(0)|file|ITEM_UPLOAD|1851954234742|5fc7046ce8ba3eb97ba3ee8a86ff31469edd89ba] new parent not found
2025/05/03 02:48:05 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:05 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725232603")
2025/05/03 02:48:06 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725232824")
2025/05/03 02:48:06 DEBUG : box root 'rclone-test-rolefuv6qige': ["B1"(0)|folder|ITEM_CREATE|319542157335|8ff6e12850dfe6589a25394163c95e8f5002ae4e] new parent not found
2025/05/03 02:48:06 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:06 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725233597")
2025/05/03 02:48:07 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725233820")
    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:48:07 DEBUG : box root 'rclone-test-rolefuv6qige': ["three"(0)|file|ITEM_UPLOAD|1851952307159|6cd7c3545b5d35f3c966233e52d8953ae6a15dde] new parent not found
2025/05/03 02:48:07 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:07 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725234599")
2025/05/03 02:48:08 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725234825")
2025/05/03 02:48:09 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725235598")
2025/05/03 02:48:09 DEBUG : box root 'rclone-test-rolefuv6qige': ["C1"(0)|folder|ITEM_CREATE|319543123152|1388937cb4cf1806d6321f6479c5fb165d07cb6c] new parent not found
2025/05/03 02:48:09 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:09 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725236599")
2025/05/03 02:48:10 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725236821")
2025/05/03 02:48:10 DEBUG : box root 'rclone-test-rolefuv6qige': ["four"(0)|file|ITEM_UPLOAD|1851950989823|5834302e9b0e027f6b6c3a1b9f8f7a51dde51cad] new parent not found
2025/05/03 02:48:10 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:10 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725237600")
2025/05/03 02:48:11 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725237831")
2025/05/03 02:48:12 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725238602")
2025/05/03 02:48:12 DEBUG : box root 'rclone-test-rolefuv6qige': ["C2"(0)|folder|ITEM_CREATE|319543986738|54537d20dc460603228b3dabe05b301bf5104788] new parent not found
2025/05/03 02:48:12 DEBUG : box root 'rclone-test-rolefuv6qige': ["five"(0)|file|ITEM_UPLOAD|1851955650089|9ae90c79f1a660336c6b5eea0319f18dc9b7fd2e] new parent not found
2025/05/03 02:48:12 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:12 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725239599")
2025/05/03 02:48:13 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725239826")
2025/05/03 02:48:14 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725240600")
2025/05/03 02:48:14 DEBUG : box root 'rclone-test-rolefuv6qige': ["B2"(0)|folder|ITEM_CREATE|319544181411|17bfa9c5f5b23bceb9d09af07e087bc15a342f5e] new parent not found
2025/05/03 02:48:14 DEBUG : box root 'rclone-test-rolefuv6qige': ["C3"(0)|folder|ITEM_CREATE|319543996013|edc0055947008a4676d23534a84a1909491413b3] new parent not found
2025/05/03 02:48:14 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:14 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725241599")
2025/05/03 02:48:15 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725241831")
2025/05/03 02:48:15 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2"(1)|file|ITEM_TRASH|1851951671556|38f9b5a891613a479c9b326368423f593c0c6921] added old path ("dir/file2") for notify
2025/05/03 02:48:15 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:48:15 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:48:15 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725242599")
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1851951042128|8f13e0643d0e7474d0464da3b74ca64f09f9395c] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/03 02:48:16 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725242820")
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': ["A2"(1)|folder|ITEM_RENAME|319542419778|9f8c2cc86f714c89bfec8f9a6ff5ac815816b103] new parent not found
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725243038")
2025/05/03 02:48:16 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725243259")
2025/05/03 02:48:17 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725243597")
2025/05/03 02:48:17 DEBUG : box root 'rclone-test-rolefuv6qige': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1851950229442|cd2b1d1a731b17858bd567b1b203d28a3c98800e] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/03 02:48:17 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/03 02:48:17 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/03 02:48:17 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725244598")
2025/05/03 02:48:18 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725244818")
2025/05/03 02:48:19 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725245599")
2025/05/03 02:48:19 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4"(1)|file|ITEM_TRASH|1851954514986|c043db5cdb91ad74a52e0295ceafdb52dbc74ee6] added old path ("dir/file4") for notify
2025/05/03 02:48:19 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1851951174586|b62bdb9ca5f3044721524f142f3da8914da24bb6] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/03 02:48:19 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:48:19 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:48:19 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/03 02:48:19 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725246601")
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': ["A3"(0)|folder|ITEM_CREATE|319543408723|88936d03881d1303cc3459fc9515f2b2bbe78d53] new parent not found
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725246839")
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725247060")
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': ["B1"(0)|folder|ITEM_CREATE|319542503562|0265acf495f869fe848902de380c9e690a785cba] new parent not found
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1851951985551|bee7d207d7e7be78e5e6df3c4c517f0ae6dc3d95] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/03 02:48:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/03 02:48:20 DEBUG : box root 'rclone-test-rolefuv6qige': Checking for changes on remote (next_stream_position: "30401043725247599")
2025/05/03 02:48:22 DEBUG : box root 'rclone-test-rolefuv6qige': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/03 02:48:22 ERROR : : error listing: directory not found
2025/05/03 02:48:22 DEBUG : box root 'rclone-test-rolefuv6qige': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (68.45s)
    --- FAIL: TestIntegration/FsMkdir (66.45s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (64.51s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	68.496s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m11.257144086s (try 5/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]