"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/28 06:22:42 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-cazefaw6ruda"
2025/04/28 06:22:42 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/04/28 06:22:42 DEBUG : Creating backend with remote "TestBox:rclone-test-cazefaw6ruda"
2025/04/28 06:22:43 DEBUG : box root 'rclone-test-cazefaw6ruda': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/28 06:22:44 DEBUG : box root 'rclone-test-cazefaw6ruda': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/04/28 06:22:46 INFO  : dir: Making directory
2025/04/28 06:22:47 INFO  : dir/subdir1: Making directory
2025/04/28 06:22:48 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306114374")
2025/04/28 06:22:48 INFO  : dir/subdir3: Making directory
2025/04/28 06:22:48 DEBUG : box root 'rclone-test-cazefaw6ruda': ["empty space"(1)|file|ITEM_RENAME|1847370246279|11fe991f1b945fccb7e27ce090167f6e5e97f7f3] new parent not found
2025/04/28 06:22:48 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(0)|file|ITEM_UPLOAD|1847372670858|950dbff8ad35c144e49b784c1f567bef96a6d351] new parent not found
2025/04/28 06:22:48 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:48 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306115600")
2025/04/28 06:22:49 INFO  : dir/subdir2: Making directory
2025/04/28 06:22:49 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306115838")
2025/04/28 06:22:50 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306116618")
2025/04/28 06:22:50 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:50 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306117603")
2025/04/28 06:22:51 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.002_f5zouy"(0)|file|ITEM_UPLOAD|1847370806197|fb9ac43fcf51279023eefa21e5ee0dd2ddb83b85] new parent not found
2025/04/28 06:22:51 DEBUG : box root 'rclone-test-cazefaw6ruda': ["rclone-test-cazefaw6ruda"(0)|folder|ITEM_CREATE|318818197739|b9f8522dfcb74f528d19c9b0537fcd7af865ad5d] new parent not found
2025/04/28 06:22:51 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:51 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306118331")
2025/04/28 06:22:51 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306118564")
2025/04/28 06:22:52 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306118792")
2025/04/28 06:22:53 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306119594")
2025/04/28 06:22:53 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:53 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306120602")
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306120844")
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306121083")
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': ["subdir1"(0)|folder|ITEM_CREATE|318818360604|82ecfa0a25810e019c20d7216743b7b5056359f5] added new path ("dir/subdir1") for notify
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': ["dir"(0)|folder|ITEM_CREATE|318818819589|c19b5ccfef5d442ea9590c375b204bcce85ad5b7] added new path ("dir") for notify
2025/04/28 06:22:54 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/04/28 06:22:54 DEBUG : doChangeNotify("dir", 0)
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 2 paths and 2 notifications
2025/04/28 06:22:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306121598")
2025/04/28 06:22:54 INFO  : dir/file2.rclone_chunk.001_f6036b: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/04/28 06:22:55 INFO  : dir/file2.rclone_chunk.002_f6036b: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/04/28 06:22:55 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306121833")
2025/04/28 06:22:56 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306122601")
2025/04/28 06:22:56 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001_f602ee"(0)|file|ITEM_UPLOAD|1847380338076|aaecc3cd685d7710af8167b59dc7b16b1c65e2ca] new parent not found
2025/04/28 06:22:56 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:56 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306123603")
2025/04/28 06:22:57 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306123837")
2025/04/28 06:22:58 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306124600")
2025/04/28 06:22:58 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2.rclone_chunk.001_f6036b"(0)|file|ITEM_UPLOAD|1847366963696|039e5fd9fea2f8563b70987fb1a6411c9c0e48d3] ignored due to old SequenceID ('\x01')
2025/04/28 06:22:58 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.002_f602ee"(0)|file|ITEM_UPLOAD|1847379791188|2172758661f37522ba666d1dcbe73052f991fb0e] new parent not found
2025/04/28 06:22:58 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:58 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306125602")
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001"(1)|file|ITEM_RENAME|1847380338076|6a8784c1129939248c2a79a5e29c145e9200998e] new parent not found
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306125841")
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306126074")
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.002"(1)|file|ITEM_RENAME|1847379791188|83cc9d675aaebf8a7222570f7450caa5e9152609] new parent not found
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:22:59 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306126606")
2025/04/28 06:23:00 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306126838")
2025/04/28 06:23:00 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2.rclone_chunk.002_f6036b"(0)|file|ITEM_UPLOAD|1847377946144|bcb5f8a37d890da000f0e65c03a80671e80f1597] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:00 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:00 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306127597")
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(0)|file|ITEM_UPLOAD|1847367565800|696534c9cb6d5f34d332c83f90203aa5b71d0f63] new parent not found
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306127823")
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306128048")
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1847366963696|b3ecc466622631911806a865460c946b15eeef22] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:01 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306128597")
2025/04/28 06:23:02 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306128819")
2025/04/28 06:23:02 INFO  : dir/file4.rclone_chunk.001_f60b6o: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/04/28 06:23:02 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2"(0)|file|ITEM_UPLOAD|1847364584406|e4b3d6ef1014904b9cf42c8bccfea3d350a044bc] ignored due to old SequenceID ('\x00')
2025/04/28 06:23:02 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:02 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306129595")
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': ["subdir2"(0)|folder|ITEM_CREATE|318816402582|06278566a790f2f3b9519418abb02a22ef77266c] ignored due to old SequenceID ('\x00')
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306129827")
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': ["subdir3"(0)|folder|ITEM_CREATE|318817777521|ccdafe3bfb896f4e7c738ab3a8b8b6a7a0525adf] ignored due to old SequenceID ('\x00')
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306130056")
2025/04/28 06:23:03 INFO  : dir/file4.rclone_chunk.002_f60b6o: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/04/28 06:23:03 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306130332")
2025/04/28 06:23:04 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306130594")
2025/04/28 06:23:04 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001_f60asy"(0)|file|ITEM_UPLOAD|1847376558891|8616a8fe94384e2b2d72eb49096822168585563c] new parent not found
2025/04/28 06:23:04 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:04 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306131602")
2025/04/28 06:23:05 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306131831")
2025/04/28 06:23:05 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4.rclone_chunk.001_f60b6o"(0)|file|ITEM_UPLOAD|1847376997717|ea8398130e5a6b6cb75538fd76a779f3fba9fe38] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:05 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:05 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306132602")
2025/04/28 06:23:06 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306132893")
2025/04/28 06:23:07 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306133599")
2025/04/28 06:23:08 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306134599")
2025/04/28 06:23:08 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:08 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306135602")
2025/04/28 06:23:09 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306135838")
2025/04/28 06:23:10 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306136600")
2025/04/28 06:23:10 INFO  : dir/file3.rclone_chunk.001_f60jm1: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/04/28 06:23:10 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1847366805393|3cab8e79442e069fca089b17197bc01af7a9713d] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:10 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1847376997717|9f4c31cb0ba4edd916bf1f63e2855e44c32e8f9c] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:10 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1847377946144|8a2dfd332cc16318aebf493743b534c75a0d25c9] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:10 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 4 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:10 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306137593")
2025/04/28 06:23:11 INFO  : dir/file3.rclone_chunk.002_f60jm1: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/04/28 06:23:11 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306137840")
2025/04/28 06:23:12 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306138598")
2025/04/28 06:23:13 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306139592")
2025/04/28 06:23:13 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file3.rclone_chunk.001_f60jm1"(0)|file|ITEM_UPLOAD|1847375087045|7daf8c8ca1d7e96237c2e7659e7768aedc258c55] added new path ("dir/file3.rclone_chunk.001_f60jm1") for notify
2025/04/28 06:23:13 DEBUG : doChangeNotify("dir/file3.rclone_chunk.001_f60jm1", 1)
2025/04/28 06:23:13 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 1 paths and 1 notifications
2025/04/28 06:23:13 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306140596")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/04/28 06:23:14 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306140832")
2025/04/28 06:23:15 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306141599")
2025/04/28 06:23:15 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4.rclone_chunk.002_f60b6o"(0)|file|ITEM_UPLOAD|1847366805393|7f7579bfa2d38645eaa53d3eff7c7b9d2b75cffe] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:15 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001_f60kn3"(0)|file|ITEM_UPLOAD|1847370116891|1d304c9627c2b362b6771126a8621d12fa842caa] new parent not found
2025/04/28 06:23:15 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file3.rclone_chunk.002_f60jm1"(0)|file|ITEM_UPLOAD|1847373572517|e31d6f3e000bb5d359022bdf73300c9b4fa3c41d] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:15 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 3 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:15 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306142595")
2025/04/28 06:23:16 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306142850")
2025/04/28 06:23:16 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(1)|file|ITEM_RENAME|1847370116891|d6d35f37bbbadc47038c00e6c6b91c1f2a0185ed] new parent not found
2025/04/28 06:23:16 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:16 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306143601")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/04/28 06:23:17 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306143839")
2025/04/28 06:23:17 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1847375087045|60a0ea322596e64f992464f5844db6d50fbe5146] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:17 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:17 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306144596")
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1847373572517|7624ff530adc4dd5d1852f9f0d482cbafa9286f9] ignored due to old SequenceID ('\x01')
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306144825")
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4"(0)|file|ITEM_UPLOAD|1847365527610|38b5ba67e8c9f596b13c92c180b3995afc29611e] ignored due to old SequenceID ('\x00')
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306145053")
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(1)|file|ITEM_RENAME|1847376558891|839bb65b805cad2bfd001369accde3a490d0bf29] new parent not found
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306145290")
2025/04/28 06:23:18 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306145523")
2025/04/28 06:23:19 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306145755")
2025/04/28 06:23:19 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001_f60ona"(0)|file|ITEM_UPLOAD|1847379702816|25aa47d6ae875ddc99800d7647ce7c6bac4844b9] new parent not found
2025/04/28 06:23:19 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:19 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306146598")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/04/28 06:23:20 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306146824")
2025/04/28 06:23:21 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306147605")
2025/04/28 06:23:21 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:21 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306148608")
2025/04/28 06:23:22 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:22 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306148848")
2025/04/28 06:23:22 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306149079")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/04/28 06:23:23 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306149600")
2025/04/28 06:23:24 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306150595")
2025/04/28 06:23:24 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file3"(0)|file|ITEM_UPLOAD|1847380537276|590cf45573db55d740a3e68c2e1eb593457d4c47] ignored due to old SequenceID ('\x00')
2025/04/28 06:23:24 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:24 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306151608")
2025/04/28 06:23:25 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:25 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306151844")
2025/04/28 06:23:25 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306152087")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/04/28 06:23:26 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306152593")
2025/04/28 06:23:27 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306153595")
2025/04/28 06:23:28 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306154612")
2025/04/28 06:23:28 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001_f60w7f"(0)|file|ITEM_UPLOAD|1847372864922|a6bee3371eb314ed66ca258fefcb4cf6e68499ef] new parent not found
2025/04/28 06:23:28 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(1)|file|ITEM_RENAME|1847372864922|1eeb4e4f4d4de12ed5c8bea1c40b1a7d96af0f6e] new parent not found
2025/04/28 06:23:28 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:28 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306155608")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/04/28 06:23:29 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306155859")
2025/04/28 06:23:29 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(1)|file|ITEM_RENAME|1847379702816|5b397be8d5c3dda39f97ae14d3d4663ba1862bb9] new parent not found
2025/04/28 06:23:29 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:29 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306156595")
2025/04/28 06:23:30 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306156825")
2025/04/28 06:23:31 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306157593")
2025/04/28 06:23:31 DEBUG : box root 'rclone-test-cazefaw6ruda': ["empty space.rclone_chunk.001_f610mx"(0)|file|ITEM_UPLOAD|1847378511748|df72edb3956f30f161ee097d98502a36b2d59db6] new parent not found
2025/04/28 06:23:31 DEBUG : box root 'rclone-test-cazefaw6ruda': ["empty space"(1)|file|ITEM_RENAME|1847378511748|5bd43060a6fd86119d7542933b137eecf8751464] new parent not found
2025/04/28 06:23:31 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:31 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306158598")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/04/28 06:23:32 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306158843")
2025/04/28 06:23:33 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306159596")
2025/04/28 06:23:34 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306160594")
2025/04/28 06:23:34 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:34 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306161599")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/04/28 06:23:35 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306161832")
2025/04/28 06:23:35 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:35 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306162595")
2025/04/28 06:23:36 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306162827")
2025/04/28 06:23:37 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306163606")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/04/28 06:23:38 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306164593")
2025/04/28 06:23:38 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato.rclone_chunk.001_f617ua"(0)|file|ITEM_UPLOAD|1847374602818|c4a8cd996df6dc233b26dd1187c4fed5a8d0acfb] new parent not found
2025/04/28 06:23:38 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:38 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306165598")
2025/04/28 06:23:39 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306165827")
2025/04/28 06:23:39 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato"(1)|file|ITEM_RENAME|1847374602818|a493197355db50f983defd677e255df719593386] new parent not found
2025/04/28 06:23:39 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:39 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306166599")
2025/04/28 06:23:40 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306166832")
    fstests.go:935: map[dir:{} dir/subdir1:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file3.rclone_chunk.001_f60jm1:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/04/28 06:23:41 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306167597")
2025/04/28 06:23:42 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306168599")
2025/04/28 06:23:43 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306169597")
2025/04/28 06:23:44 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306170597")
2025/04/28 06:23:45 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306171597")
2025/04/28 06:23:45 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato2.rclone_chunk.001_f61f57"(0)|file|ITEM_UPLOAD|1847378099814|5678b0fe5d6e6e5d50d681eb34a6dc160c68d737] new parent not found
2025/04/28 06:23:45 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:45 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306172601")
2025/04/28 06:23:46 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306172826")
2025/04/28 06:23:47 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306173605")
2025/04/28 06:23:47 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato2.rclone_chunk.002_f61f57"(0)|file|ITEM_UPLOAD|1847378356061|79b3262d4a284e7db6bc82afa6f95d51d750dac1] new parent not found
2025/04/28 06:23:47 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:47 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306174594")
2025/04/28 06:23:48 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306174826")
2025/04/28 06:23:48 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato2.rclone_chunk.001"(1)|file|ITEM_RENAME|1847378099814|c335ff8a0bf54d09d2fa8e12a3d7d73ed7415b37] new parent not found
2025/04/28 06:23:48 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 1 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:48 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306175599")
2025/04/28 06:23:49 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306175828")
2025/04/28 06:23:49 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1847366963696|d75f4ca773c778cebd19e89411c5c996b5027d75] added old path ("dir/file2.rclone_chunk.001") for notify
2025/04/28 06:23:49 DEBUG : box root 'rclone-test-cazefaw6ruda': ["empty space.rclone_chunk.001_f61b1q"(0)|file|ITEM_UPLOAD|1847380492226|eb653aa1ba6f5bc139843f5f5c70a1aacb1e9316] new parent not found
2025/04/28 06:23:49 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato2.rclone_chunk.002"(1)|file|ITEM_RENAME|1847378356061|a4c806b0d34fc374a91005f221a4a6868c8c6e51] new parent not found
2025/04/28 06:23:49 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/28 06:23:49 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 3 events, resulting in 1 paths and 1 notifications
2025/04/28 06:23:49 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306176599")
2025/04/28 06:23:50 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306176861")
2025/04/28 06:23:50 DEBUG : box root 'rclone-test-cazefaw6ruda': ["potato2"(0)|file|ITEM_UPLOAD|1847378396972|56834415b3d62fcd9c1bd855ebbcd1c46d854c6e] new parent not found
2025/04/28 06:23:50 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1847377946144|90a1d049e5d508a5095b8ce87c96652a8f8ae648] added old path ("dir/file2.rclone_chunk.002") for notify
2025/04/28 06:23:50 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file2"(1)|file|ITEM_TRASH|1847364584406|e29cb29b06b2e671e2541b8a93899b6537b8dd6b] added old path ("dir/file2") for notify
2025/04/28 06:23:50 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/28 06:23:50 DEBUG : doChangeNotify("dir/file2", 1)
2025/04/28 06:23:50 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/28 06:23:50 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306177602")
2025/04/28 06:23:51 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306177833")
2025/04/28 06:23:51 DEBUG : box root 'rclone-test-cazefaw6ruda': ["empty space"(1)|file|ITEM_RENAME|1847380492226|b0a51459e1c9f0d74e78418e1fa26f92a5db3f29] new parent not found
2025/04/28 06:23:51 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 0 paths and 0 notifications
2025/04/28 06:23:51 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306178594")
2025/04/28 06:23:52 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306178833")
2025/04/28 06:23:53 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306179593")
2025/04/28 06:23:53 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4"(1)|file|ITEM_TRASH|1847365527610|4db145069443f1d0e884637f53d53453bc996442] added old path ("dir/file4") for notify
2025/04/28 06:23:53 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1847376997717|4168161705352b446b3b46607176db73aa521ada] added old path ("dir/file4.rclone_chunk.001") for notify
2025/04/28 06:23:53 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/28 06:23:53 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/28 06:23:53 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 3 events, resulting in 2 paths and 2 notifications
2025/04/28 06:23:53 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306180593")
2025/04/28 06:23:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306180840")
2025/04/28 06:23:54 DEBUG : box root 'rclone-test-cazefaw6ruda': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1847366805393|a010aea535b8509aaa6888299ac0c3d1fdd6742c] added old path ("dir/file4.rclone_chunk.002") for notify
2025/04/28 06:23:54 DEBUG : doChangeNotify("dir/file4", 1)
2025/04/28 06:23:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Received 2 events, resulting in 1 paths and 1 notifications
2025/04/28 06:23:54 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306181592")
2025/04/28 06:23:55 DEBUG : box root 'rclone-test-cazefaw6ruda': Checking for changes on remote (next_stream_position: "30401043306181830")
2025/04/28 06:23:57 DEBUG : box root 'rclone-test-cazefaw6ruda': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/04/28 06:23:57 ERROR : : error listing: directory not found
2025/04/28 06:23:58 DEBUG : box root 'rclone-test-cazefaw6ruda': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (75.26s)
    --- FAIL: TestIntegration/FsMkdir (72.01s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (69.71s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	75.310s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m17.905397507s (try 3/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]