"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/05/16 02:51:29 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-gejeyen9jazu"
2025/05/16 02:51:29 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/05/16 02:51:29 DEBUG : Creating backend with remote "TestBox:rclone-test-gejeyen9jazu"
2025/05/16 02:51:30 DEBUG : box root 'rclone-test-gejeyen9jazu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/16 02:51:30 DEBUG : box root 'rclone-test-gejeyen9jazu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/05/16 02:51:32 INFO  : dir: Making directory
2025/05/16 02:51:34 INFO  : dir/subdir1: Making directory
2025/05/16 02:51:35 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848640860")
2025/05/16 02:51:35 INFO  : dir/subdir3: Making directory
2025/05/16 02:51:35 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.txt"(7)|file|ITEM_UPLOAD|1863825979097|9c2bc20183bdb0021c6b9eb1f10e491646965126] new parent not found
2025/05/16 02:51:35 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:35 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848642086")
2025/05/16 02:51:36 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848642315")
2025/05/16 02:51:36 INFO  : dir/subdir2: Making directory
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848643092")
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1863824318149|9cb021221a84fb043f731ab0d7dc1b7579416d56] new parent not found
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848644098")
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': ["rclone-test-gejeyen9jazu"(0)|folder|ITEM_CREATE|321448192615|072a2b9a3713f94cb949263b08037684ce0b6060] new parent not found
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848644329")
2025/05/16 02:51:38 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848644559")
2025/05/16 02:51:39 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848645097")
2025/05/16 02:51:39 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:39 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848646570")
2025/05/16 02:51:40 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848646804")
2025/05/16 02:51:41 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848647088")
2025/05/16 02:51:41 DEBUG : box root 'rclone-test-gejeyen9jazu': ["subdir1"(0)|folder|ITEM_CREATE|321446910670|96c253c07c2ab9e1e9e6d6a14d49a4f989a7b881] added new path ("dir/subdir1") for notify
2025/05/16 02:51:41 DEBUG : box root 'rclone-test-gejeyen9jazu': ["subdir3"(0)|folder|ITEM_CREATE|321444729484|2b20f8660a3806f5dc013cf9ccaf561b8794a57a] added new path ("dir/subdir3") for notify
2025/05/16 02:51:41 DEBUG : doChangeNotify("dir/subdir1", 0)
2025/05/16 02:51:41 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/05/16 02:51:41 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/16 02:51:41 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848648085")
2025/05/16 02:51:42 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848648313")
2025/05/16 02:51:42 INFO  : dir/file2.rclone_chunk.001_c889ku: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/05/16 02:51:42 INFO  : dir/file2.rclone_chunk.002_c889ku: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/05/16 02:51:43 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848649107")
2025/05/16 02:51:43 DEBUG : box root 'rclone-test-gejeyen9jazu': ["dir"(0)|folder|ITEM_CREATE|321444203220|21398610185ad945c8fecfc109f94a5bfba1d265] added new path ("dir") for notify
2025/05/16 02:51:43 DEBUG : doChangeNotify("dir", 0)
2025/05/16 02:51:43 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/16 02:51:43 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848650104")
2025/05/16 02:51:44 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848650336")
2025/05/16 02:51:44 DEBUG : box root 'rclone-test-gejeyen9jazu': ["subdir2"(0)|folder|ITEM_CREATE|321444728835|73bfd8dbe1c5298084b6fd0c41035093375e31cc] added new path ("dir/subdir2") for notify
2025/05/16 02:51:44 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/05/16 02:51:44 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/16 02:51:44 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848651092")
2025/05/16 02:51:45 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848651322")
2025/05/16 02:51:45 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.txt"(1)|file|ITEM_UPLOAD|1863819402280|e992c9e7dac447a524d2f8b8281af876434cea5e] new parent not found
2025/05/16 02:51:45 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:45 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848652088")
2025/05/16 02:51:46 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848652325")
2025/05/16 02:51:46 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.rclone_chunk.001_c889ku"(0)|file|ITEM_UPLOAD|1863826324310|0f6821b3832ade9b7ba0cb4165156ec9db83f57f] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:46 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:46 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848653091")
2025/05/16 02:51:47 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848653317")
2025/05/16 02:51:48 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848654090")
2025/05/16 02:51:48 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.rclone_chunk.002_c889ku"(0)|file|ITEM_UPLOAD|1863810104581|8ad37cfb7f60e712689d161b11751205f43bc770] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:48 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1863826324310|440711b2e41e00374a9acdc513675bc87cb94077] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:48 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:48 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848655084")
2025/05/16 02:51:49 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848655311")
2025/05/16 02:51:49 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1863810104581|4dce2a0f9bb54adac67b8f3002ed4b7c29dd80a8] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:49 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:49 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848656084")
2025/05/16 02:51:50 INFO  : dir/file4.rclone_chunk.001_c88hci: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/05/16 02:51:50 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848656310")
2025/05/16 02:51:50 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2"(0)|file|ITEM_UPLOAD|1863816861262|28bfafcb3152d8e08f468e69ef9be628850800e8] ignored due to old SequenceID ('\x00')
2025/05/16 02:51:50 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.txt"(7)|file|ITEM_RENAME|1863825979097|1b576beb5f52d1e377aed5fd96531f82a21c3792] new parent not found
2025/05/16 02:51:50 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:50 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848657090")
2025/05/16 02:51:50 INFO  : dir/file4.rclone_chunk.002_c88hci: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/05/16 02:51:51 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848657325")
2025/05/16 02:51:52 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848658094")
2025/05/16 02:51:52 DEBUG : box root 'rclone-test-gejeyen9jazu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1863826105366|b4e52f9f28ae5dd7c51926e56bbfd07f06b47b02] new parent not found
2025/05/16 02:51:52 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:52 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848659093")
2025/05/16 02:51:53 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848659325")
2025/05/16 02:51:53 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:53 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848660088")
2025/05/16 02:51:54 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848660331")
2025/05/16 02:51:54 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4.rclone_chunk.001_c88hci"(0)|file|ITEM_UPLOAD|1863818044074|c86ad7e99c15a3c664925bfa38e9bf47d43b872b] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:54 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:54 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848661090")
2025/05/16 02:51:55 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848661322")
2025/05/16 02:51:55 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4.rclone_chunk.002_c88hci"(0)|file|ITEM_UPLOAD|1863827351603|f0f6ec9a471919757d931c52a376236961b4c74e] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:55 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:55 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848662102")
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848662334")
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1863818044074|84a740d5aedd9f09e3b3b8684063d5af1030713a] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848663088")
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1863827351603|c0a09d4f2a0a6798428301d5b1b8afc3aa0d2d53] ignored due to old SequenceID ('\x01')
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:56 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848663318")
2025/05/16 02:51:57 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848663550")
2025/05/16 02:51:57 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4"(0)|file|ITEM_UPLOAD|1863823471068|76ff89a9520460dfe1404969f8f66e4fe994559b] ignored due to old SequenceID ('\x00')
2025/05/16 02:51:57 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:57 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848664089")
2025/05/16 02:51:57 INFO  : dir/file3.rclone_chunk.001_c88pdm: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/05/16 02:51:58 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848664312")
2025/05/16 02:51:58 INFO  : dir/file3.rclone_chunk.002_c88pdm: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/05/16 02:51:59 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848665089")
2025/05/16 02:51:59 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.txt"(1)|file|ITEM_RENAME|1863819402280|44a504be2655afcf01a65fd78d8a9aa5761ce9ca] new parent not found
2025/05/16 02:51:59 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:51:59 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848666087")
2025/05/16 02:52:00 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848666323")
    fstests.go:931: Try 1/10 waiting for dirChanges and objChanges
2025/05/16 02:52:01 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848667084")
2025/05/16 02:52:01 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file3.rclone_chunk.001_c88pdm"(0)|file|ITEM_UPLOAD|1863826521587|0fe99a2a939b8111290553c7feb275c00b6a3acf] ignored due to old SequenceID ('\x01')
2025/05/16 02:52:01 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:01 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848668092")
2025/05/16 02:52:02 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848668325")
2025/05/16 02:52:02 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.txt"(7)|file|ITEM_RENAME|1863825979097|8f699a92b443b101f862f939a470f24c849676df] new parent not found
2025/05/16 02:52:02 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file3.rclone_chunk.002_c88pdm"(0)|file|ITEM_UPLOAD|1863819511188|e5a273b74c100c1493c687fe70cf68588495abc4] ignored due to old SequenceID ('\x01')
2025/05/16 02:52:02 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:02 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848669093")
2025/05/16 02:52:03 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848669325")
    fstests.go:931: Try 2/10 waiting for dirChanges and objChanges
2025/05/16 02:52:04 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848670089")
2025/05/16 02:52:04 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1863826521587|99e06a7ead1562f4a0e765a16ad2b651b8f26977] ignored due to old SequenceID ('\x01')
2025/05/16 02:52:04 DEBUG : box root 'rclone-test-gejeyen9jazu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1863816873547|b08e96ee41d3032929ae00ec19cc19f36c07e234] new parent not found
2025/05/16 02:52:04 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1863819511188|2fbdb3a2194e6c439cca0ba09c394ec10cd69c7e] ignored due to old SequenceID ('\x01')
2025/05/16 02:52:04 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:04 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848671089")
2025/05/16 02:52:05 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848671334")
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848672097")
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file3"(0)|file|ITEM_UPLOAD|1863813810667|aedd7624bb2322aca558a42216b781f0f33c8cca] ignored due to old SequenceID ('\x00')
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.txt"(8)|file|ITEM_UPLOAD|1863825979097|7eb24ac305784d4985a1df201c987289ce7b90c6] new parent not found
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 3 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848673089")
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.txt"(2)|file|ITEM_UPLOAD|1863819402280|6c3693d7b3a4894de6deb19af027b34b18a7a77f] new parent not found
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:06 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848673332")
    fstests.go:931: Try 3/10 waiting for dirChanges and objChanges
2025/05/16 02:52:07 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848673562")
2025/05/16 02:52:08 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848674091")
2025/05/16 02:52:09 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848675082")
2025/05/16 02:52:09 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:09 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848676089")
2025/05/16 02:52:09 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:09 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848676318")
    fstests.go:931: Try 4/10 waiting for dirChanges and objChanges
2025/05/16 02:52:10 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848676551")
2025/05/16 02:52:10 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:10 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848677085")
2025/05/16 02:52:11 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848677316")
2025/05/16 02:52:11 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:11 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848678087")
2025/05/16 02:52:12 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848678325")
    fstests.go:931: Try 5/10 waiting for dirChanges and objChanges
2025/05/16 02:52:13 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848679089")
2025/05/16 02:52:14 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848680090")
2025/05/16 02:52:15 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848681091")
    fstests.go:931: Try 6/10 waiting for dirChanges and objChanges
2025/05/16 02:52:16 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848682089")
2025/05/16 02:52:17 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848683083")
2025/05/16 02:52:18 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848684084")
    fstests.go:931: Try 7/10 waiting for dirChanges and objChanges
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848685086")
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': ["path1"(0)|folder|ITEM_CREATE|321448074779|bec72d0e32e2c70b07161ac00379dc5fa3b8d8de] new parent not found
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848686085")
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': ["subdir"(0)|folder|ITEM_CREATE|321447126131|25288b3093798511ef5aa1ad8972e79e6d2ca66b] new parent not found
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848686320")
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': ["rmdirs"(0)|folder|ITEM_CREATE|321446620268|a0c878743abdc492e1899b0e2588cf905906a03b] new parent not found
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:19 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848686596")
2025/05/16 02:52:20 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848686827")
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848687093")
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.copy2.txt"(0)|file|ITEM_UPLOAD|1863815629737|6190f95865cb361e4bc81b33ebed18af96358bdd] new parent not found
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848688083")
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.copy4.txt"(0)|file|ITEM_UPLOAD|1863814963108|645f2ab8e06b36b75fb9731f0db051cbb5cc013f] new parent not found
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848688319")
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.copy1.txt"(0)|file|ITEM_UPLOAD|1863816705409|65adab2b11ce405e69a46c9b6b373c70ef456377] new parent not found
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:21 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848688551")
    fstests.go:931: Try 8/10 waiting for dirChanges and objChanges
2025/05/16 02:52:22 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.copy5.txt"(0)|file|ITEM_UPLOAD|1863817996280|2d786741842bc71c4de641e96ed2b55368702cd4] new parent not found
2025/05/16 02:52:22 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.copy3.txt"(0)|file|ITEM_UPLOAD|1863820914604|387590455aa687a41c82bacf2f7605e8fae0be4c] new parent not found
2025/05/16 02:52:22 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:22 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848688782")
2025/05/16 02:52:22 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848689017")
2025/05/16 02:52:23 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848689243")
2025/05/16 02:52:24 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848690089")
2025/05/16 02:52:24 DEBUG : box root 'rclone-test-gejeyen9jazu': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1863810328659|e54df783894540d0d73e0f6f209f8ba046d02855] new parent not found
2025/05/16 02:52:24 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file20.txt"(0)|file|ITEM_UPLOAD|1863814055326|dcecc875747096b29fd11d7b8016d3ff1e50bcd3] new parent not found
2025/05/16 02:52:24 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:24 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848691086")
    fstests.go:931: Try 9/10 waiting for dirChanges and objChanges
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848691322")
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file1.txt"(0)|file|ITEM_UPLOAD|1863811310224|ae6e1be0cc1be62ad11722627294a127cbc099fe] new parent not found
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848692092")
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1863814513435|cb1c2cac1abd6ef1595f64250bde907509f10922] new parent not found
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:25 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848692322")
2025/05/16 02:52:26 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848692562")
2025/05/16 02:52:26 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:26 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848693345")
2025/05/16 02:52:27 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848693572")
    fstests.go:935: map[dir:{} dir/subdir1:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[] does not contain [dir/file2 dir/file4 dir/file3]
2025/05/16 02:52:28 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848694093")
2025/05/16 02:52:29 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848695091")
2025/05/16 02:52:30 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848696090")
2025/05/16 02:52:31 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848697090")
2025/05/16 02:52:32 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848698093")
2025/05/16 02:52:33 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848699095")
2025/05/16 02:52:34 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848700088")
2025/05/16 02:52:34 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:34 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848701081")
2025/05/16 02:52:35 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848701327")
2025/05/16 02:52:35 DEBUG : box root 'rclone-test-gejeyen9jazu': ["modtime_write_test"(0)|file|ITEM_UPLOAD|1863816736711|8b7387042254ceb5b2a98779e9f90130870602a0] new parent not found
2025/05/16 02:52:35 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2"(1)|file|ITEM_TRASH|1863816861262|dcb626733a3523b9a960da8bea2efe7505334961] added old path ("dir/file2") for notify
2025/05/16 02:52:35 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/16 02:52:35 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 1 paths and 1 notifications
2025/05/16 02:52:35 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848702086")
2025/05/16 02:52:36 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848702327")
2025/05/16 02:52:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848703090")
2025/05/16 02:52:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 0 paths and 0 notifications
2025/05/16 02:52:37 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848704098")
2025/05/16 02:52:38 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848704324")
2025/05/16 02:52:38 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1863826324310|5ec96bf259576e4b4dbc7075c48e5f41127c811f] added old path ("dir/file2.rclone_chunk.001") for notify
2025/05/16 02:52:38 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1863810104581|cda668fb7ad0becc6087b676b1c3ee0225a33936] added old path ("dir/file2.rclone_chunk.002") for notify
2025/05/16 02:52:38 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/16 02:52:38 DEBUG : doChangeNotify("dir/file2", 1)
2025/05/16 02:52:38 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/16 02:52:38 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848705090")
2025/05/16 02:52:39 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848705334")
2025/05/16 02:52:40 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848706090")
2025/05/16 02:52:40 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4"(1)|file|ITEM_TRASH|1863823471068|9f0d8ecd176b443be5ee90c4fc897b31c026b690] added old path ("dir/file4") for notify
2025/05/16 02:52:40 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/16 02:52:40 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 1 events, resulting in 1 paths and 1 notifications
2025/05/16 02:52:40 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848707136")
2025/05/16 02:52:41 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848707368")
2025/05/16 02:52:42 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848708089")
2025/05/16 02:52:42 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1863818044074|42a30bdfd7a391c76425dce0b2bc351e71dfeb4c] added old path ("dir/file4.rclone_chunk.001") for notify
2025/05/16 02:52:42 DEBUG : box root 'rclone-test-gejeyen9jazu': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1863827351603|082ffc46838924320921c603e111c674da71f39a] added old path ("dir/file4.rclone_chunk.002") for notify
2025/05/16 02:52:42 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/16 02:52:42 DEBUG : doChangeNotify("dir/file4", 1)
2025/05/16 02:52:42 DEBUG : box root 'rclone-test-gejeyen9jazu': Received 2 events, resulting in 2 paths and 2 notifications
2025/05/16 02:52:42 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848709103")
2025/05/16 02:52:43 DEBUG : box root 'rclone-test-gejeyen9jazu': Checking for changes on remote (next_stream_position: "30401044848709344")
2025/05/16 02:52:45 DEBUG : box root 'rclone-test-gejeyen9jazu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/05/16 02:52:45 ERROR : : error listing: directory not found
2025/05/16 02:52:46 DEBUG : box root 'rclone-test-gejeyen9jazu': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (76.54s)
    --- FAIL: TestIntegration/FsMkdir (73.66s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (70.90s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	76.591s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m19.113989555s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]