"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:438: Using remote "TestChunkerChunk50bBox:"
2025/03/23 01:49:45 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-vurorim9puwe"
2025/03/23 01:49:45 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/03/23 01:49:45 DEBUG : Creating backend with remote "TestBox:rclone-test-vurorim9puwe"
2025/03/23 01:49:45 DEBUG : box root 'rclone-test-vurorim9puwe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/23 01:49:46 DEBUG : Reset feature "ListR"
2025/03/23 01:49:46 DEBUG : box root 'rclone-test-vurorim9puwe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/03/23 01:49:47 INFO  : dir: Making directory
2025/03/23 01:49:48 INFO  : dir/subdir1: Making directory
2025/03/23 01:49:49 INFO  : dir/subdir3: Making directory
2025/03/23 01:49:49 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179335698")
2025/03/23 01:49:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101926950|2e270bcd421271040f266c00ccebe80effec43c2] new parent not found
2025/03/23 01:49:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["dir"(0)|folder|ITEM_CREATE|313000789225|c246a91fb7465e6a661df888411b3c827a58741b] added new path ("dir") for notify
2025/03/23 01:49:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["rclone-test-vurorim9puwe"(0)|folder|ITEM_CREATE|312998521213|5bdaf269622531f65be33a6099799d65b99cc4af] new parent not found
2025/03/23 01:49:50 DEBUG : doChangeNotify("dir", 0)
2025/03/23 01:49:50 DEBUG : box root 'rclone-test-vurorim9puwe': Received 4 events, resulting in 1 paths and 1 notifications
2025/03/23 01:49:50 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179336921")
2025/03/23 01:49:50 INFO  : dir/subdir2: Making directory
2025/03/23 01:49:50 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179337171")
2025/03/23 01:49:51 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179337921")
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101926950|2e270bcd421271040f266c00ccebe80effec43c2] ignored due to duplicate EventID
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': ["dir"(0)|folder|ITEM_CREATE|313000789225|c246a91fb7465e6a661df888411b3c827a58741b] ignored due to duplicate EventID
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': ["rclone-test-vurorim9puwe"(0)|folder|ITEM_CREATE|312998521213|5bdaf269622531f65be33a6099799d65b99cc4af] ignored due to duplicate EventID
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir1"(0)|folder|ITEM_CREATE|313000402843|3f497e99c672dbbc38e256817a09e1b8f99a29cf] added new path ("dir/subdir1") for notify
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101468031|a67f7b4827b541252cc25c694efb6ca82ca87980] new parent not found
2025/03/23 01:49:52 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': Received 5 events, resulting in 1 paths and 1 notifications
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179338921")
2025/03/23 01:49:52 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179339170")
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101926950|2e270bcd421271040f266c00ccebe80effec43c2] ignored due to duplicate EventID
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': ["dir"(0)|folder|ITEM_CREATE|313000789225|c246a91fb7465e6a661df888411b3c827a58741b] ignored due to duplicate EventID
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': ["rclone-test-vurorim9puwe"(0)|folder|ITEM_CREATE|312998521213|5bdaf269622531f65be33a6099799d65b99cc4af] ignored due to duplicate EventID
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir1"(0)|folder|ITEM_CREATE|313000402843|3f497e99c672dbbc38e256817a09e1b8f99a29cf] ignored due to duplicate EventID
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101468031|a67f7b4827b541252cc25c694efb6ca82ca87980] ignored due to duplicate EventID
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir3"(0)|folder|ITEM_CREATE|312999272487|b6531f5dbdf6e67cdcf8116a350aa8471aa5e429] added new path ("dir/subdir3") for notify
2025/03/23 01:49:53 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': Received 7 events, resulting in 1 paths and 1 notifications
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179339922")
2025/03/23 01:49:53 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179340183")
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101926950|2e270bcd421271040f266c00ccebe80effec43c2] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["dir"(0)|folder|ITEM_CREATE|313000789225|c246a91fb7465e6a661df888411b3c827a58741b] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["rclone-test-vurorim9puwe"(0)|folder|ITEM_CREATE|312998521213|5bdaf269622531f65be33a6099799d65b99cc4af] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir1"(0)|folder|ITEM_CREATE|313000402843|3f497e99c672dbbc38e256817a09e1b8f99a29cf] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101468031|a67f7b4827b541252cc25c694efb6ca82ca87980] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir3"(0)|folder|ITEM_CREATE|312999272487|b6531f5dbdf6e67cdcf8116a350aa8471aa5e429] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101926950|085cf071b876eb98a22af47ff06e99f1e6289e27] ignored due to duplicate EventID
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811100383825|a20298c0d2176eba77629fa6492eb28724d4abb6] new parent not found
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': Received 8 events, resulting in 0 paths and 0 notifications
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179340922")
2025/03/23 01:49:54 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179341197")
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir1"(0)|folder|ITEM_CREATE|313000402843|3f497e99c672dbbc38e256817a09e1b8f99a29cf] ignored due to duplicate EventID
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101468031|a67f7b4827b541252cc25c694efb6ca82ca87980] ignored due to duplicate EventID
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir3"(0)|folder|ITEM_CREATE|312999272487|b6531f5dbdf6e67cdcf8116a350aa8471aa5e429] ignored due to duplicate EventID
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101926950|085cf071b876eb98a22af47ff06e99f1e6289e27] ignored due to duplicate EventID
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811100383825|a20298c0d2176eba77629fa6492eb28724d4abb6] ignored due to duplicate EventID
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir2"(0)|folder|ITEM_CREATE|312998430081|cb35c22ac41540f2c046988cbe4dbf65c900ebe6] added new path ("dir/subdir2") for notify
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001_k5cqsu"(0)|file|ITEM_UPLOAD|1811092842729|1ef61dc649f427846b57c3fbfd028ebe5cfa93b1] added new path ("dir/file2.rclone_chunk.001_k5cqsu") for notify
2025/03/23 01:49:55 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/03/23 01:49:55 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_k5cqsu", 1)
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': Received 15 events, resulting in 2 paths and 2 notifications
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179341926")
2025/03/23 01:49:55 INFO  : dir/file2.rclone_chunk.001_k5cqsu: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/03/23 01:49:55 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179342238")
2025/03/23 01:49:56 INFO  : dir/file2.rclone_chunk.002_k5cqsu: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir1"(0)|folder|ITEM_CREATE|313000402843|3f497e99c672dbbc38e256817a09e1b8f99a29cf] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101468031|a67f7b4827b541252cc25c694efb6ca82ca87980] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir3"(0)|folder|ITEM_CREATE|312999272487|b6531f5dbdf6e67cdcf8116a350aa8471aa5e429] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101926950|085cf071b876eb98a22af47ff06e99f1e6289e27] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811100383825|a20298c0d2176eba77629fa6492eb28724d4abb6] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811100383825|fe8621e479dd84aa354daf14b64b65050a7e1cb7] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["path1"(1)|folder|ITEM_TRASH|312999356997|e3f2596f7dbec071cae8767263f7e6174ea3dc71] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.txt"(1)|file|ITEM_TRASH|1811094575780|e98990ba3224f8befb725f3429ba9adcf66f6b10] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir2"(0)|folder|ITEM_CREATE|312998430081|cb35c22ac41540f2c046988cbe4dbf65c900ebe6] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.txt"(1)|file|ITEM_TRASH|1811091934808|2c78bd403f73ec5ca778ecf64f0b760573700627] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["file20.txt"(1)|file|ITEM_TRASH|1811096702309|7be1066db965069a710a5628e1df74dbd465914d] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir"(1)|folder|ITEM_TRASH|313000413229|edd1dea852005d62c8bb98d0f23183b30848bd25] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001_k5cqsu"(0)|file|ITEM_UPLOAD|1811092842729|1ef61dc649f427846b57c3fbfd028ebe5cfa93b1] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811092298016|cd736e8e3e3ca6760bad2fbd5fa84cc957f6412f] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': ["file1.txt"(1)|file|ITEM_TRASH|1811096754192|3948724eb1c3f5060658770d2c7b8140b4861903] ignored due to duplicate EventID
2025/03/23 01:49:56 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179342927")
2025/03/23 01:49:57 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir3"(0)|folder|ITEM_CREATE|312999272487|b6531f5dbdf6e67cdcf8116a350aa8471aa5e429] ignored due to duplicate EventID
2025/03/23 01:49:57 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101926950|085cf071b876eb98a22af47ff06e99f1e6289e27] ignored due to duplicate EventID
2025/03/23 01:49:57 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179343924")
2025/03/23 01:49:58 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811100383825|a20298c0d2176eba77629fa6492eb28724d4abb6] ignored due to duplicate EventID
2025/03/23 01:49:58 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179344928")
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811100383825|fe8621e479dd84aa354daf14b64b65050a7e1cb7] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["path1"(1)|folder|ITEM_TRASH|312999356997|e3f2596f7dbec071cae8767263f7e6174ea3dc71] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.txt"(1)|file|ITEM_TRASH|1811094575780|e98990ba3224f8befb725f3429ba9adcf66f6b10] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir2"(0)|folder|ITEM_CREATE|312998430081|cb35c22ac41540f2c046988cbe4dbf65c900ebe6] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.txt"(1)|file|ITEM_TRASH|1811091934808|2c78bd403f73ec5ca778ecf64f0b760573700627] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["file20.txt"(1)|file|ITEM_TRASH|1811096702309|7be1066db965069a710a5628e1df74dbd465914d] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir"(1)|folder|ITEM_TRASH|313000413229|edd1dea852005d62c8bb98d0f23183b30848bd25] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001_k5cqsu"(0)|file|ITEM_UPLOAD|1811092842729|1ef61dc649f427846b57c3fbfd028ebe5cfa93b1] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811092298016|cd736e8e3e3ca6760bad2fbd5fa84cc957f6412f] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': ["file1.txt"(1)|file|ITEM_TRASH|1811096754192|3948724eb1c3f5060658770d2c7b8140b4861903] ignored due to duplicate EventID
2025/03/23 01:49:59 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179345923")
2025/03/23 01:50:00 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179346950")
2025/03/23 01:50:01 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.002_k5cqsu"(0)|file|ITEM_UPLOAD|1811091268701|31f1ab974c5e6d44aadef7c0425fb50a16bcee06] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:01 DEBUG : box root 'rclone-test-vurorim9puwe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:01 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179347924")
2025/03/23 01:50:01 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179348154")
2025/03/23 01:50:02 INFO  : dir/file4.rclone_chunk.001_k5cxwf: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/03/23 01:50:02 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179348929")
2025/03/23 01:50:02 INFO  : dir/file4.rclone_chunk.002_k5cxwf: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1811091268701|49c6a521edc70efe2a352d2385d57714baa0e571] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179349923")
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': ["check_access_filters"(0)|folder|ITEM_CREATE|313000852111|cffe5a933a0608213db35bf755e4c86afa18a5a9] new parent not found
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179350157")
2025/03/23 01:50:03 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179350398")
2025/03/23 01:50:04 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179350927")
2025/03/23 01:50:05 DEBUG : box root 'rclone-test-vurorim9puwe': ["path1"(0)|folder|ITEM_CREATE|312999469302|47eb5a6f00957dbe6b195e323a923326bed86c8b] new parent not found
2025/03/23 01:50:05 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:05 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179351926")
2025/03/23 01:50:05 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179352164")
2025/03/23 01:50:06 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir"(0)|folder|ITEM_CREATE|312998936624|c8abe34bd8e17de622f93370913c94ba2b1ebb88] new parent not found
2025/03/23 01:50:06 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir-not"(0)|folder|ITEM_CREATE|312999777574|fe2223b042fa5353432f60247d2d0e123cbab0da] new parent not found
2025/03/23 01:50:06 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:06 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179352927")
2025/03/23 01:50:06 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179353164")
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.001_k5cxwf"(0)|file|ITEM_UPLOAD|1811101043800|e6fcb71006f47fb90a5261daa0bfd7dabff89751] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirX"(0)|folder|ITEM_CREATE|313000747065|3ba50f9de8416ca0bd270e533a32b3be40c3e347] new parent not found
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179353927")
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirX1"(0)|folder|ITEM_CREATE|312998675405|b49fd5e3639d3674b5bd4d8d33ef023d085e415b] new parent not found
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179354170")
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002_k5cxwf"(0)|file|ITEM_UPLOAD|1811092902729|cc8c3c5b4808fbbe388ee15698896c5698d263fc] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1811092902729|d4c696fce10a51a4400e2f4a4ba8799069d76105] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirA"(0)|folder|ITEM_CREATE|313000765625|01ba9464ab257fe42bae8971807a3284cfeeee5f] new parent not found
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1811101043800|f2324259ab1d70093cb28f8b821817dbc3a8b9d8] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirB"(0)|folder|ITEM_CREATE|312998747690|760372d1c1cedbad3291108ae216be32726fc938] new parent not found
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1811092842729|b6aaafdd02dc5d608c2075a83282f72860a86be5] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4"(0)|file|ITEM_UPLOAD|1811094376490|2781613eb2636f15f06ebc5ee14af5e11aea07af] ignored due to old SequenceID ('\x00')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2"(0)|file|ITEM_UPLOAD|1811094943026|3acdca5b3e837e23ec41c925fbd814b645b6636f] ignored due to old SequenceID ('\x00')
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir-not2"(0)|folder|ITEM_CREATE|312998075623|7a379e74f303cc5854628398ecc1d0f9f105eb46] new parent not found
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.txt"(0)|file|ITEM_UPLOAD|1811097270838|67fea58b1df2b338be35841ef46f87ede3962955] new parent not found
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Received 10 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179354398")
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002_k5cxwf"(0)|file|ITEM_UPLOAD|1811092902729|cc8c3c5b4808fbbe388ee15698896c5698d263fc] ignored due to duplicate EventID
2025/03/23 01:50:07 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179354696")
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1811092902729|d4c696fce10a51a4400e2f4a4ba8799069d76105] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirA"(0)|folder|ITEM_CREATE|313000765625|01ba9464ab257fe42bae8971807a3284cfeeee5f] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1811101043800|f2324259ab1d70093cb28f8b821817dbc3a8b9d8] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirB"(0)|folder|ITEM_CREATE|312998747690|760372d1c1cedbad3291108ae216be32726fc938] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1811092842729|b6aaafdd02dc5d608c2075a83282f72860a86be5] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4"(0)|file|ITEM_UPLOAD|1811094376490|2781613eb2636f15f06ebc5ee14af5e11aea07af] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2"(0)|file|ITEM_UPLOAD|1811094943026|3acdca5b3e837e23ec41c925fbd814b645b6636f] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir-not2"(0)|folder|ITEM_CREATE|312998075623|7a379e74f303cc5854628398ecc1d0f9f105eb46] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.txt"(0)|file|ITEM_UPLOAD|1811097270838|67fea58b1df2b338be35841ef46f87ede3962955] ignored due to duplicate EventID
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': ["file1.txt"(0)|file|ITEM_UPLOAD|1811095410417|5d920bec23cca53fea17a94ab83ca165e356f04f] new parent not found
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': Received 10 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179354929")
2025/03/23 01:50:08 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179355227")
2025/03/23 01:50:09 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1811092902729|d4c696fce10a51a4400e2f4a4ba8799069d76105] ignored due to duplicate EventID
2025/03/23 01:50:09 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirA"(0)|folder|ITEM_CREATE|313000765625|01ba9464ab257fe42bae8971807a3284cfeeee5f] ignored due to duplicate EventID
2025/03/23 01:50:09 INFO  : dir/file3.rclone_chunk.001_k5d481: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/03/23 01:50:09 INFO  : dir/file3.rclone_chunk.002_k5d481: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/03/23 01:50:09 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179355928")
2025/03/23 01:50:10 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1811101043800|f2324259ab1d70093cb28f8b821817dbc3a8b9d8] ignored due to duplicate EventID
2025/03/23 01:50:10 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdirB"(0)|folder|ITEM_CREATE|312998747690|760372d1c1cedbad3291108ae216be32726fc938] ignored due to duplicate EventID
2025/03/23 01:50:10 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1811092842729|b6aaafdd02dc5d608c2075a83282f72860a86be5] ignored due to duplicate EventID
2025/03/23 01:50:10 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179356923")
2025/03/23 01:50:11 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4"(0)|file|ITEM_UPLOAD|1811094376490|2781613eb2636f15f06ebc5ee14af5e11aea07af] ignored due to duplicate EventID
2025/03/23 01:50:11 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2"(0)|file|ITEM_UPLOAD|1811094943026|3acdca5b3e837e23ec41c925fbd814b645b6636f] ignored due to duplicate EventID
2025/03/23 01:50:11 DEBUG : box root 'rclone-test-vurorim9puwe': ["subdir-not2"(0)|folder|ITEM_CREATE|312998075623|7a379e74f303cc5854628398ecc1d0f9f105eb46] ignored due to duplicate EventID
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/03/23 01:50:11 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179357932")
2025/03/23 01:50:12 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.txt"(0)|file|ITEM_UPLOAD|1811097270838|67fea58b1df2b338be35841ef46f87ede3962955] ignored due to duplicate EventID
2025/03/23 01:50:12 DEBUG : box root 'rclone-test-vurorim9puwe': ["file1.txt"(0)|file|ITEM_UPLOAD|1811095410417|5d920bec23cca53fea17a94ab83ca165e356f04f] ignored due to duplicate EventID
2025/03/23 01:50:12 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179358921")
2025/03/23 01:50:13 DEBUG : box root 'rclone-test-vurorim9puwe': ["file20.txt"(0)|file|ITEM_UPLOAD|1811094070905|82f1129d01df15d81141381e686b7680ba19f72b] new parent not found
2025/03/23 01:50:13 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.001_k5d481"(0)|file|ITEM_UPLOAD|1811102055843|38c0dd6d7c2164da258b36c68ae567628df6477e] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:13 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:13 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179359923")
2025/03/23 01:50:13 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179360161")
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811094674282|55e2325df20b19e2542921543c12296c4ce90b0c] new parent not found
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811095333302|484fe3d4033be2c6e7d9ab0008fbb18df5c98559] new parent not found
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179360920")
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.002_k5d481"(0)|file|ITEM_UPLOAD|1811092348166|402e9fff464107efb91eb5f04fffa591ca00da34] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': ["file20.txt"(0)|file|ITEM_UPLOAD|1811096617469|93e7d607bf01c5d57d871e076bf34a00e990fb35] new parent not found
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179361162")
2025/03/23 01:50:14 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179361401")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file20.txt"(0)|file|ITEM_UPLOAD|1811095081223|9fc2b9dcb8bad9a0ce10310fc178127edc35725f] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1811102055843|4250bc01daec75f4633cebcef126ee3b949cbd60] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811095067005|e54f0e2024dddd553cc62c0400f75a287f1dd5e5] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811092220504|43a9f696d9919bb3b782356b063b10d1633a6984] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811095232796|a40ee3907a7460a7ea74a7b63253406d83cf66ff] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811093401217|a0b45eb472d1cbd8922e33dc0ae58330142183cd] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1811092348166|3b4542e0c672bad13b9c4a21e185d4ac111456d9] ignored due to old SequenceID ('\x01')
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3"(0)|file|ITEM_UPLOAD|1811095306852|d30aa85d57ff76b62c9b71e29bc9ac644f71491e] ignored due to old SequenceID ('\x00')
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811094945380|0e088c0ddcb5431c6db5046efe546eb470fa83c5] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811100112243|b5c5bc9ebd535a22c5ba5d52e7b42f33758d82f5] new parent not found
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': Received 10 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179361930")
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1811102055843|4250bc01daec75f4633cebcef126ee3b949cbd60] ignored due to duplicate EventID
2025/03/23 01:50:15 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179362232")
2025/03/23 01:50:16 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811095067005|e54f0e2024dddd553cc62c0400f75a287f1dd5e5] ignored due to duplicate EventID
2025/03/23 01:50:16 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811092220504|43a9f696d9919bb3b782356b063b10d1633a6984] ignored due to duplicate EventID
2025/03/23 01:50:16 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811095232796|a40ee3907a7460a7ea74a7b63253406d83cf66ff] ignored due to duplicate EventID
2025/03/23 01:50:16 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811093401217|a0b45eb472d1cbd8922e33dc0ae58330142183cd] ignored due to duplicate EventID
2025/03/23 01:50:16 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179362926")
2025/03/23 01:50:17 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1811092348166|3b4542e0c672bad13b9c4a21e185d4ac111456d9] ignored due to duplicate EventID
2025/03/23 01:50:17 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3"(0)|file|ITEM_UPLOAD|1811095306852|d30aa85d57ff76b62c9b71e29bc9ac644f71491e] ignored due to duplicate EventID
2025/03/23 01:50:17 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811094945380|0e088c0ddcb5431c6db5046efe546eb470fa83c5] ignored due to duplicate EventID
2025/03/23 01:50:17 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811100112243|b5c5bc9ebd535a22c5ba5d52e7b42f33758d82f5] ignored due to duplicate EventID
2025/03/23 01:50:17 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179363926")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/03/23 01:50:18 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179364927")
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811094839221|517c41ed6a08c33f1cf87dbd5046121c34553f8a] new parent not found
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.txt"(0)|file|ITEM_UPLOAD|1811097023295|a9adcd44966b1377f8f4eb8762a4eda19b04b9d9] new parent not found
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811101101204|926dbdadef29ffc64113afe55badc9fcb4b30491] new parent not found
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.txt"(0)|file|ITEM_UPLOAD|1811092674774|be77fd14ea8fe0d069e3ed68eb1e766b2d12d726] new parent not found
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811092823821|b1c648ddb67c32bb9f9a286910c2328d6b6f0e88] new parent not found
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179365922")
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811094839221|517c41ed6a08c33f1cf87dbd5046121c34553f8a] ignored due to duplicate EventID
2025/03/23 01:50:19 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179366188")
2025/03/23 01:50:20 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.txt"(0)|file|ITEM_UPLOAD|1811097023295|a9adcd44966b1377f8f4eb8762a4eda19b04b9d9] ignored due to duplicate EventID
2025/03/23 01:50:20 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179366921")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811101101204|926dbdadef29ffc64113afe55badc9fcb4b30491] ignored due to duplicate EventID
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.txt"(0)|file|ITEM_UPLOAD|1811092674774|be77fd14ea8fe0d069e3ed68eb1e766b2d12d726] ignored due to duplicate EventID
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811092823821|b1c648ddb67c32bb9f9a286910c2328d6b6f0e88] ignored due to duplicate EventID
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811094790935|bb6a969a4d28755ec8eec968a64ec6207e8aea88] new parent not found
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': Received 4 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179367922")
2025/03/23 01:50:21 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179368167")
2025/03/23 01:50:22 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179368923")
2025/03/23 01:50:23 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179369921")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/03/23 01:50:24 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179370922")
2025/03/23 01:50:25 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811094790935|bb6a969a4d28755ec8eec968a64ec6207e8aea88] ignored due to duplicate EventID
2025/03/23 01:50:25 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811092218104|6bce5ad4634f40b5b6c0c99da957631529a6bb90] new parent not found
2025/03/23 01:50:25 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811096425239|c90d320af0595954000fa6b21e1c5cce978a0016] new parent not found
2025/03/23 01:50:25 DEBUG : box root 'rclone-test-vurorim9puwe': Received 5 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:25 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179371931")
2025/03/23 01:50:25 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179372185")
2025/03/23 01:50:26 DEBUG : box root 'rclone-test-vurorim9puwe': ["file30.txt"(0)|file|ITEM_UPLOAD|1811092218104|6bce5ad4634f40b5b6c0c99da957631529a6bb90] ignored due to duplicate EventID
2025/03/23 01:50:26 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811092823821|e936f35a50130cb03ce896434a0850c8c1171bf4] ignored due to duplicate EventID
2025/03/23 01:50:26 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179372921")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/03/23 01:50:27 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811096425239|c90d320af0595954000fa6b21e1c5cce978a0016] ignored due to duplicate EventID
2025/03/23 01:50:27 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811096425239|70182d0609267e45fbd04c7b3c81a0beafb7bfd3] ignored due to duplicate EventID
2025/03/23 01:50:27 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179373921")
2025/03/23 01:50:28 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811096425239|c90d320af0595954000fa6b21e1c5cce978a0016] ignored due to duplicate EventID
2025/03/23 01:50:28 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179374922")
2025/03/23 01:50:29 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811096425239|70182d0609267e45fbd04c7b3c81a0beafb7bfd3] ignored due to duplicate EventID
2025/03/23 01:50:29 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179375924")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/03/23 01:50:30 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179376925")
2025/03/23 01:50:31 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179377924")
2025/03/23 01:50:32 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101084144|d98d8d14a172f2ddba37c7ed97f2c61eefa42bf0] new parent not found
2025/03/23 01:50:32 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:32 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179378921")
2025/03/23 01:50:32 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179379153")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/03/23 01:50:33 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179379923")
2025/03/23 01:50:34 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101084144|d98d8d14a172f2ddba37c7ed97f2c61eefa42bf0] ignored due to duplicate EventID
2025/03/23 01:50:34 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101084144|a89fc1747172e19c10aa2ca806e8597eb65291b5] ignored due to duplicate EventID
2025/03/23 01:50:34 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179380923")
2025/03/23 01:50:35 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179381923")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/03/23 01:50:36 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101084144|d98d8d14a172f2ddba37c7ed97f2c61eefa42bf0] ignored due to duplicate EventID
2025/03/23 01:50:36 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101084144|a89fc1747172e19c10aa2ca806e8597eb65291b5] ignored due to duplicate EventID
2025/03/23 01:50:36 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179382927")
2025/03/23 01:50:37 DEBUG : box root 'rclone-test-vurorim9puwe': Received 1 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:37 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179383923")
2025/03/23 01:50:37 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811095333302|c5f4b5d5fd8a53d6767866ea55923425fcc4b680] ignored due to duplicate EventID
2025/03/23 01:50:37 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179384153")
2025/03/23 01:50:38 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179384942")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2.rclone_chunk.001_k5cqsu:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/03/23 01:50:39 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811095333302|c5f4b5d5fd8a53d6767866ea55923425fcc4b680] ignored due to duplicate EventID
2025/03/23 01:50:39 DEBUG : box root 'rclone-test-vurorim9puwe': Received 2 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:39 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179385927")
2025/03/23 01:50:39 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179386170")
2025/03/23 01:50:40 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811095333302|c5f4b5d5fd8a53d6767866ea55923425fcc4b680] ignored due to duplicate EventID
2025/03/23 01:50:40 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811094790935|3226de913a861bf6c0f60c84ba38b34b933b3242] ignored due to duplicate EventID
2025/03/23 01:50:40 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101194166|be0c15a9293298660d35d7b2859ff4b4b6e8eaf0] new parent not found
2025/03/23 01:50:40 DEBUG : box root 'rclone-test-vurorim9puwe': Received 3 events, resulting in 0 paths and 0 notifications
2025/03/23 01:50:40 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179386927")
2025/03/23 01:50:40 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179387160")
2025/03/23 01:50:41 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811094790935|3226de913a861bf6c0f60c84ba38b34b933b3242] ignored due to duplicate EventID
2025/03/23 01:50:41 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101194166|be0c15a9293298660d35d7b2859ff4b4b6e8eaf0] ignored due to duplicate EventID
2025/03/23 01:50:41 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179387921")
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811094790935|3226de913a861bf6c0f60c84ba38b34b933b3242] ignored due to duplicate EventID
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101194166|be0c15a9293298660d35d7b2859ff4b4b6e8eaf0] ignored due to duplicate EventID
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2"(1)|file|ITEM_TRASH|1811094943026|32d43280d79c09926364841cf457b3edf22d343a] added old path ("dir/file2") for notify
2025/03/23 01:50:42 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': Received 4 events, resulting in 1 paths and 1 notifications
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179388925")
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811094790935|3226de913a861bf6c0f60c84ba38b34b933b3242] ignored due to duplicate EventID
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101194166|be0c15a9293298660d35d7b2859ff4b4b6e8eaf0] ignored due to duplicate EventID
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2"(1)|file|ITEM_TRASH|1811094943026|32d43280d79c09926364841cf457b3edf22d343a] ignored due to duplicate EventID
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101194166|9fe611c0427f1eca47e896ed38097c2ffe18e26f] ignored due to duplicate EventID
2025/03/23 01:50:42 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179389182")
2025/03/23 01:50:43 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(1)|file|ITEM_TRASH|1811094790935|3226de913a861bf6c0f60c84ba38b34b933b3242] ignored due to duplicate EventID
2025/03/23 01:50:43 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179389922")
2025/03/23 01:50:44 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811101194166|be0c15a9293298660d35d7b2859ff4b4b6e8eaf0] ignored due to duplicate EventID
2025/03/23 01:50:44 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179390925")
2025/03/23 01:50:45 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179391930")
2025/03/23 01:50:46 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2"(1)|file|ITEM_TRASH|1811094943026|32d43280d79c09926364841cf457b3edf22d343a] ignored due to duplicate EventID
2025/03/23 01:50:46 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(1)|file|ITEM_TRASH|1811101194166|9fe611c0427f1eca47e896ed38097c2ffe18e26f] ignored due to duplicate EventID
2025/03/23 01:50:46 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179392924")
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1811092842729|3c46bed84977fa1b1ae4c42301310f76bd60a161] added old path ("dir/file2.rclone_chunk.001") for notify
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1811091268701|b919644480fc4c37acf6080f05650b4a5e395d67] added old path ("dir/file2.rclone_chunk.002") for notify
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4"(1)|file|ITEM_TRASH|1811094376490|a77e3156ff884656a9600da061e735b2bf544298] added old path ("dir/file4") for notify
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1811101043800|d667f9dee0458845f9ea22fe468c024519c7c941] added old path ("dir/file4.rclone_chunk.001") for notify
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811102336643|dcb2b84265021d008ff606f11c87e51c17fbae90] new parent not found
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1811092902729|3fbbc812a5bc1149dc19d4285162826c75fb05dd] added old path ("dir/file4.rclone_chunk.002") for notify
2025/03/23 01:50:47 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/23 01:50:47 DEBUG : doChangeNotify("dir/file2", 1)
2025/03/23 01:50:47 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/23 01:50:47 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/23 01:50:47 DEBUG : doChangeNotify("dir/file4", 1)
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': Received 6 events, resulting in 5 paths and 5 notifications
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179393925")
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1811091268701|b919644480fc4c37acf6080f05650b4a5e395d67] ignored due to duplicate EventID
2025/03/23 01:50:47 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179394186")
2025/03/23 01:50:48 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179394921")
2025/03/23 01:50:49 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4"(1)|file|ITEM_TRASH|1811094376490|a77e3156ff884656a9600da061e735b2bf544298] ignored due to duplicate EventID
2025/03/23 01:50:49 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179395926")
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1811101043800|d667f9dee0458845f9ea22fe468c024519c7c941] ignored due to duplicate EventID
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811102336643|dcb2b84265021d008ff606f11c87e51c17fbae90] ignored due to duplicate EventID
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1811092902729|3fbbc812a5bc1149dc19d4285162826c75fb05dd] ignored due to duplicate EventID
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811094388055|a1ad9e64981b403ae819fab9b8e5abba9b3819b5] new parent not found
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811093817518|65189dafadc6bceb09dc8357e3b005708360d250] new parent not found
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1811094580363|90fd835ae9027ddbfbba8e452adeefb20dc10807] new parent not found
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1811102055843|ec0d5463389bc01025362c4f911a8958ac13b59e] added old path ("dir/file3.rclone_chunk.001") for notify
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["file3"(1)|file|ITEM_TRASH|1811095306852|1d9cec062f728b58ebaa122ebe2b09f04b669266] added old path ("dir/file3") for notify
2025/03/23 01:50:50 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/23 01:50:50 DEBUG : doChangeNotify("dir/file3", 1)
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': Received 9 events, resulting in 2 paths and 2 notifications
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179396923")
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1811102336643|dcb2b84265021d008ff606f11c87e51c17fbae90] ignored due to duplicate EventID
2025/03/23 01:50:50 DEBUG : box root 'rclone-test-vurorim9puwe': Checking for changes on remote (next_stream_position: "30401040179397210")
2025/03/23 01:50:51 DEBUG : box root 'rclone-test-vurorim9puwe': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1811092902729|3fbbc812a5bc1149dc19d4285162826c75fb05dd] ignored due to duplicate EventID
2025/03/23 01:50:52 DEBUG : box root 'rclone-test-vurorim9puwe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/03/23 01:50:52 ERROR : : error listing: directory not found
2025/03/23 01:50:53 DEBUG : box root 'rclone-test-vurorim9puwe': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (68.01s)
    --- FAIL: TestIntegration/FsMkdir (65.80s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (63.83s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	68.056s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m11.640521483s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]