"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/04/16 04:16:06 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-mivogoq5rari"
2025/04/16 04:16:06 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/16 04:16:06 DEBUG : Creating backend with remote "TestBox:rclone-test-mivogoq5rari"
2025/04/16 04:16:07 DEBUG : box root 'rclone-test-mivogoq5rari': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/16 04:16:08 DEBUG : box root 'rclone-test-mivogoq5rari': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/16 04:16:10 INFO  : dir: Making directory
2025/04/16 04:16:12 INFO  : dir/subdir1: Making directory
2025/04/16 04:16:13 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261718765")
2025/04/16 04:16:13 INFO  : dir/subdir3: Making directory
2025/04/16 04:16:13 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.001_ss4mjk"(0)|file|ITEM_UPLOAD|1835457743376|97afe6bf42d9fd66fd6855a8c760663c402d08a0] new parent not found
2025/04/16 04:16:13 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:13 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261720020")
2025/04/16 04:16:14 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261720262")
2025/04/16 04:16:14 INFO  : dir/subdir2: Making directory
2025/04/16 04:16:15 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261721004")
2025/04/16 04:16:15 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.002_ss4mjk"(0)|file|ITEM_UPLOAD|1835464139446|35aff865be5525ac59cc0750822e5ebb867cb167] new parent not found
2025/04/16 04:16:15 DEBUG : box root 'rclone-test-mivogoq5rari': ["rclone-test-mivogoq5rari"(0)|folder|ITEM_CREATE|316927832697|63777514e7e1e1a5ab9389e3627fb63e3d82f690] new parent not found
2025/04/16 04:16:15 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:15 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261722012")
2025/04/16 04:16:16 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261722243")
2025/04/16 04:16:17 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261723010")
2025/04/16 04:16:18 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261724005")
2025/04/16 04:16:18 DEBUG : box root 'rclone-test-mivogoq5rari': ["dir"(0)|folder|ITEM_CREATE|316926722065|452a48332d4b0727ee13ab477c57158153492c90] added new path ("dir") for notify
2025/04/16 04:16:18 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.003_ss4mjk"(0)|file|ITEM_UPLOAD|1835465245732|491904d1fe3c414ab79b53a774019df457eeed57] new parent not found
2025/04/16 04:16:18 DEBUG : doChangeNotify("dir", 0)
2025/04/16 04:16:18 DEBUG : box root 'rclone-test-mivogoq5rari': Received 3 events, resulting in 1 paths and 1 notifications
2025/04/16 04:16:18 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261725006")
2025/04/16 04:16:19 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261725254")
2025/04/16 04:16:19 DEBUG : box root 'rclone-test-mivogoq5rari': ["subdir1"(0)|folder|ITEM_CREATE|316926212888|b55620fd0b3393c5445fa961c74d8ca6ac5f2cfc] added new path ("dir/subdir1") for notify
2025/04/16 04:16:19 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/16 04:16:19 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/16 04:16:19 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261726003")
2025/04/16 04:16:20 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261726245")
2025/04/16 04:16:20 INFO  : dir/file2.rclone_chunk.001_ss4xl2: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261727003")
2025/04/16 04:16:21 INFO  : dir/file2.rclone_chunk.002_ss4xl2: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': ["subdir3"(0)|folder|ITEM_CREATE|316928250177|4777a3ff1ef4e8a1b74ff21626ef4be9556b5a2f] added new path ("dir/subdir3") for notify
2025/04/16 04:16:21 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261727998")
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': ["subdir2"(0)|folder|ITEM_CREATE|316928397144|5914425ac32d3861978e2e82262fa9c87627352b] added new path ("dir/subdir2") for notify
2025/04/16 04:16:21 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/16 04:16:21 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261728244")
2025/04/16 04:16:22 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261728491")
2025/04/16 04:16:23 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261729006")
2025/04/16 04:16:23 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:23 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261730002")
2025/04/16 04:16:24 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261730255")
2025/04/16 04:16:24 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.001"(1)|file|ITEM_RENAME|1835457743376|ac1d241c25b267d6605bf4d6c4935a09f70de574] new parent not found
2025/04/16 04:16:24 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.002"(1)|file|ITEM_RENAME|1835464139446|5c2e2d7e086746d3bcf4c5f7586cca8382e6e221] new parent not found
2025/04/16 04:16:24 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:24 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261731002")
2025/04/16 04:16:25 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261731254")
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261732001")
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.003"(1)|file|ITEM_RENAME|1835465245732|1e0a9d35f14159236322e51a73f7bac9e6a2bd83] new parent not found
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2.rclone_chunk.001_ss4xl2"(0)|file|ITEM_UPLOAD|1835460632833|9437b655efad2dbaa8e457a1f8c9e1dee163715b] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261733017")
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum"(5)|file|ITEM_UPLOAD|1835482640501|92e8dd7380cf75a92afc6dd72e6fc90491d6acca] new parent not found
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:26 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261733264")
2025/04/16 04:16:27 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261733510")
2025/04/16 04:16:27 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1835460632833|01f0d6f2ef93996cc09ea1bbe78f404758c5fa8a] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:27 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:27 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261734008")
2025/04/16 04:16:28 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261734251")
2025/04/16 04:16:28 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1835461219091|1facb806cd94c6a8e6910f18960fe7a15185d703] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:28 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:28 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261735010")
2025/04/16 04:16:28 INFO  : dir/file4.rclone_chunk.001_ss56al: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/16 04:16:29 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261735253")
2025/04/16 04:16:29 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2"(0)|file|ITEM_UPLOAD|1835483574490|13aa04fca39748fb55c789bce9613bc6c6a342fe] ignored due to old SequenceID ('\x00')
2025/04/16 04:16:29 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:29 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261736014")
2025/04/16 04:16:29 INFO  : dir/file4.rclone_chunk.002_ss56al: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/16 04:16:30 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261736260")
2025/04/16 04:16:31 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261737008")
2025/04/16 04:16:32 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261738015")
2025/04/16 04:16:33 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261739004")
2025/04/16 04:16:33 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2.rclone_chunk.002_ss4xl2"(0)|file|ITEM_UPLOAD|1835461219091|16bea409060c5cac78a337e5cf80b712b97f99ce] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:33 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:33 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261739995")
2025/04/16 04:16:34 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261740235")
2025/04/16 04:16:34 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4.rclone_chunk.002_ss56al"(0)|file|ITEM_UPLOAD|1835465115753|92e006f337a8ec3736ef4e2b8743938c4c9b56b1] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:34 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1835455698052|5b3a3ddd8dbf2256ec87a7148ca6e9ae02b5d475] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:34 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:34 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261741013")
2025/04/16 04:16:35 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261741264")
2025/04/16 04:16:36 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261741997")
2025/04/16 04:16:36 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1835465115753|d436ce3c83c6a677878c76899360e6d62ddbdb9b] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:36 DEBUG : box root 'rclone-test-mivogoq5rari': ["banana.rclone_chunk.001_ss5acv"(0)|file|ITEM_UPLOAD|1835467504788|3efe5e29996adbad5e9dc82a1d853f251ab3efb6] new parent not found
2025/04/16 04:16:36 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:36 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261743005")
2025/04/16 04:16:37 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261743266")
2025/04/16 04:16:37 INFO  : dir/file3.rclone_chunk.001_ss5eg6: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/16 04:16:37 INFO  : dir/file3.rclone_chunk.002_ss5eg6: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/16 04:16:38 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261744014")
2025/04/16 04:16:38 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4"(0)|file|ITEM_UPLOAD|1835457846613|b20a5000f7dd01285496a6c675c737dc5fd834a0] ignored due to old SequenceID ('\x00')
2025/04/16 04:16:38 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:38 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261745001")
2025/04/16 04:16:39 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261745240")
2025/04/16 04:16:40 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261746001")
2025/04/16 04:16:40 DEBUG : box root 'rclone-test-mivogoq5rari': ["banana"(1)|file|ITEM_RENAME|1835467504788|0cbf5e4066f50a3ee5e0a1e6dc1136ed12ccaf42] new parent not found
2025/04/16 04:16:40 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4.rclone_chunk.001_ss56al"(0)|file|ITEM_UPLOAD|1835455698052|12946004382cac560b81ae15b33cee1ba58a656b] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:40 DEBUG : box root 'rclone-test-mivogoq5rari': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:40 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261747004")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/16 04:16:41 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261747256")
2025/04/16 04:16:42 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261748004")
2025/04/16 04:16:42 DEBUG : box root 'rclone-test-mivogoq5rari': ["file3.rclone_chunk.001_ss5eg6"(0)|file|ITEM_UPLOAD|1835458120176|adaabca827f7bb8e18db5f7205c37a657b190783] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:42 DEBUG : box root 'rclone-test-mivogoq5rari': ["file3.rclone_chunk.002_ss5eg6"(0)|file|ITEM_UPLOAD|1835458727965|a6d9097a174dbf54ae6924a4125e78d82b6ce5b9] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:42 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:42 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261749010")
2025/04/16 04:16:43 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261749263")
2025/04/16 04:16:43 DEBUG : box root 'rclone-test-mivogoq5rari': ["potato.rclone_chunk.001_ss5hcp"(0)|file|ITEM_UPLOAD|1835472184794|4662b3dead990555e76676391431fd22cf262954] new parent not found
2025/04/16 04:16:43 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:43 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261750003")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/16 04:16:44 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261750244")
2025/04/16 04:16:45 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261750995")
2025/04/16 04:16:45 DEBUG : box root 'rclone-test-mivogoq5rari': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1835458120176|97aab446c9b6931df30a906beb14bb1c3eee1177] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:45 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:45 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261752013")
2025/04/16 04:16:46 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261752249")
2025/04/16 04:16:46 DEBUG : box root 'rclone-test-mivogoq5rari': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1835458727965|eb0011631f5e3cb06ae9db3732f62d83202f3a8c] ignored due to old SequenceID ('\x01')
2025/04/16 04:16:46 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:46 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261753018")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/16 04:16:47 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261753263")
2025/04/16 04:16:47 DEBUG : box root 'rclone-test-mivogoq5rari': ["file3"(0)|file|ITEM_UPLOAD|1835466282422|14523cd477f906baa866cfa173ad1e90a002c12b] ignored due to old SequenceID ('\x00')
2025/04/16 04:16:47 DEBUG : box root 'rclone-test-mivogoq5rari': ["potato"(1)|file|ITEM_RENAME|1835472184794|3bd1b7f1ac63c1d6abbd418fe25cbcb31b99ed8e] new parent not found
2025/04/16 04:16:47 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:47 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261754015")
2025/04/16 04:16:48 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261754264")
2025/04/16 04:16:48 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:48 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261754997")
2025/04/16 04:16:49 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261755241")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/16 04:16:50 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261756005")
2025/04/16 04:16:51 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261757016")
2025/04/16 04:16:52 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261758010")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/16 04:16:53 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261759008")
2025/04/16 04:16:53 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.002_ss5pwa"(0)|file|ITEM_UPLOAD|1835471408904|cf2f56b335f8a159e25a8eb6d0433ec5cdb2449a] new parent not found
2025/04/16 04:16:53 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.001_ss5pwa"(0)|file|ITEM_UPLOAD|1835457285367|13cba1eb4c3cbc3c24537e8fac008920bb5dc971] new parent not found
2025/04/16 04:16:53 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:53 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261760017")
2025/04/16 04:16:54 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261760267")
2025/04/16 04:16:55 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261761004")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/16 04:16:56 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261762022")
2025/04/16 04:16:56 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:56 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261763010")
2025/04/16 04:16:57 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261763256")
2025/04/16 04:16:58 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261763999")
2025/04/16 04:16:58 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:58 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261765007")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/16 04:16:59 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261765247")
2025/04/16 04:16:59 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.002"(1)|file|ITEM_RENAME|1835471408904|e6bd449dc2e47637b0dbcf056af7a3ba46643624] new parent not found
2025/04/16 04:16:59 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:16:59 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261766004")
2025/04/16 04:17:00 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261766244")
2025/04/16 04:17:01 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261767004")
2025/04/16 04:17:01 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum"(6)|file|ITEM_UPLOAD|1835482640501|93fc0b0bc49d141c8737720f918480186590eb54] new parent not found
2025/04/16 04:17:01 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:01 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261768001")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/16 04:17:02 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261768242")
2025/04/16 04:17:03 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261769014")
2025/04/16 04:17:04 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261770009")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/16 04:17:05 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261771007")
2025/04/16 04:17:05 DEBUG : box root 'rclone-test-mivogoq5rari': ["test.sum.rclone_chunk.001"(1)|file|ITEM_RENAME|1835457285367|1fe4c5884d2ffb9e66a2fd462cd0c28fd51347af] new parent not found
2025/04/16 04:17:05 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:05 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261772004")
2025/04/16 04:17:06 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261772251")
2025/04/16 04:17:07 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261772998")
    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/16 04:17:08 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261774002")
2025/04/16 04:17:09 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261775010")
2025/04/16 04:17:09 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:09 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261776032")
2025/04/16 04:17:10 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261776287")
2025/04/16 04:17:11 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261777011")
2025/04/16 04:17:11 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:11 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261777996")
2025/04/16 04:17:12 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261778237")
2025/04/16 04:17:13 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261779041")
2025/04/16 04:17:13 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:13 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261780007")
2025/04/16 04:17:14 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261780243")
2025/04/16 04:17:14 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:14 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261781010")
2025/04/16 04:17:15 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261781259")
2025/04/16 04:17:16 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261782008")
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261783000")
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1835460632833|e9d8c1b7155243cea75bfb63c90940a11ea984f8] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1835461219091|b2c0cdce743edaf7a5ae64a1439b42f0306d378b] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/16 04:17:17 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/16 04:17:17 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261784004")
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': ["rclone-test-papemap4nira"(0)|folder|ITEM_CREATE|316928699935|980c3e4d4de667ed8251881e59255fe2563a2b2d] new parent not found
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:17 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261784251")
2025/04/16 04:17:18 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261784494")
2025/04/16 04:17:19 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261785017")
2025/04/16 04:17:20 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261786001")
2025/04/16 04:17:20 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4"(1)|file|ITEM_TRASH|1835457846613|a6dee1cf9f4bda485303bcf97bd91d8fb22b9fb6] added old path ("dir/file4") for notify
2025/04/16 04:17:20 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1835455698052|06643da11dc3077834c30cde69908823357fe343] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/16 04:17:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/16 04:17:20 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/16 04:17:20 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/16 04:17:20 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261787011")
2025/04/16 04:17:21 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261787261")
2025/04/16 04:17:21 DEBUG : box root 'rclone-test-mivogoq5rari': ["hello, world!.rclone_chunk.001_ss6h14"(0)|file|ITEM_UPLOAD|1835465432727|aa59c71476f454f36737e6deedbd25ad0404fee8] new parent not found
2025/04/16 04:17:21 DEBUG : box root 'rclone-test-mivogoq5rari': ["hello, world!"(1)|file|ITEM_RENAME|1835465432727|cf83b267c75d6f47e2b90d3e303c4552acb66ae8] new parent not found
2025/04/16 04:17:21 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/16 04:17:21 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261788003")
2025/04/16 04:17:22 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261788252")
2025/04/16 04:17:22 DEBUG : box root 'rclone-test-mivogoq5rari': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1835465115753|144d3e7bf4a27eb3f840378455a3c881b0c7017d] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/16 04:17:22 DEBUG : box root 'rclone-test-mivogoq5rari': ["file2"(1)|file|ITEM_TRASH|1835483574490|ef12967974af8dd5d11324a1e0d9e6a1de90438e] added old path ("dir/file2") for notify
2025/04/16 04:17:22 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/16 04:17:22 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/16 04:17:22 DEBUG : box root 'rclone-test-mivogoq5rari': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/16 04:17:22 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261789006")
2025/04/16 04:17:23 DEBUG : box root 'rclone-test-mivogoq5rari': Checking for changes on remote (next_stream_position: "30401042261789259")
2025/04/16 04:17:25 DEBUG : box root 'rclone-test-mivogoq5rari': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/16 04:17:25 ERROR : : error listing: directory not found
2025/04/16 04:17:26 DEBUG : box root 'rclone-test-mivogoq5rari': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (79.67s)
    --- FAIL: TestIntegration/FsMkdir (76.29s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (73.72s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	79.734s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m22.347589936s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]