"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Starting (try 2/5)
=== RUN   TestIntegration
    fstests.go:442: Using remote "TestChunkerChunk50bBox:"
2025/02/21 03:40:58 DEBUG : Creating backend with remote "TestChunkerChunk50bBox:rclone-test-bisecop6kaja"
2025/02/21 03:40:58 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2025/02/21 03:40:58 DEBUG : Creating backend with remote "TestBox:rclone-test-bisecop6kaja"
2025/02/21 03:40:59 DEBUG : box root 'rclone-test-bisecop6kaja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/02/21 03:40:59 DEBUG : Reset feature "ListR"
2025/02/21 03:41:00 DEBUG : box root 'rclone-test-bisecop6kaja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
=== RUN   TestIntegration/FsMkdir
=== RUN   TestIntegration/FsMkdir/FsChangeNotify
2025/02/21 03:41:01 INFO  : dir: Making directory
2025/02/21 03:41:03 INFO  : dir/subdir1: Making directory
2025/02/21 03:41:04 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594010119")
2025/02/21 03:41:04 INFO  : dir/subdir3: Making directory
2025/02/21 03:41:05 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594011349")
2025/02/21 03:41:05 INFO  : dir/subdir2: Making directory
2025/02/21 03:41:06 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594012356")
2025/02/21 03:41:06 DEBUG : box root 'rclone-test-bisecop6kaja': ["rclone-test-bisecop6kaja"(0)|folder|ITEM_CREATE|308484385439|43dda74ac2c3fc2d5882e860a9993efb42e88d79] new parent not found
2025/02/21 03:41:06 DEBUG : box root 'rclone-test-bisecop6kaja': ["dir"(0)|folder|ITEM_CREATE|308488432780|92b41810c417a7e3a8e3a02e4852b9ff096a5337] added new path ("dir") for notify
2025/02/21 03:41:06 DEBUG : doChangeNotify("dir", 0)
2025/02/21 03:41:06 DEBUG : box root 'rclone-test-bisecop6kaja': Received 2 events, resulting in 1 paths and 1 notifications
2025/02/21 03:41:06 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594013351")
2025/02/21 03:41:07 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594013583")
2025/02/21 03:41:08 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594014350")
2025/02/21 03:41:08 DEBUG : box root 'rclone-test-bisecop6kaja': ["rclone-test-bisecop6kaja"(0)|folder|ITEM_CREATE|308484385439|43dda74ac2c3fc2d5882e860a9993efb42e88d79] ignored due to duplicate EventID
2025/02/21 03:41:09 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594015345")
2025/02/21 03:41:10 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594016352")
2025/02/21 03:41:10 DEBUG : box root 'rclone-test-bisecop6kaja': ["dir"(0)|folder|ITEM_CREATE|308488432780|92b41810c417a7e3a8e3a02e4852b9ff096a5337] ignored due to duplicate EventID
2025/02/21 03:41:11 INFO  : dir/file2.rclone_chunk.001_0qhyg5: Moved (server-side) to: dir/file2.rclone_chunk.001
2025/02/21 03:41:11 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594017346")
2025/02/21 03:41:11 INFO  : dir/file2.rclone_chunk.002_0qhyg5: Moved (server-side) to: dir/file2.rclone_chunk.002
2025/02/21 03:41:12 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594018353")
2025/02/21 03:41:12 DEBUG : box root 'rclone-test-bisecop6kaja': ["subdir3"(0)|folder|ITEM_CREATE|308486584325|0ad21b0f4cebc534e2af483001eb5bfb6c1c91a7] added new path ("dir/subdir3") for notify
2025/02/21 03:41:12 DEBUG : box root 'rclone-test-bisecop6kaja': ["subdir2"(0)|folder|ITEM_CREATE|308489365451|7aeddf3af375f4e47dba6472c94fee4d42becfc1] added new path ("dir/subdir2") for notify
2025/02/21 03:41:12 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001_0qhyg5"(0)|file|ITEM_UPLOAD|1783735324135|5d3d44d15e68560414fbb09e8f544c85f3116b96] added new path ("dir/file2.rclone_chunk.001_0qhyg5") for notify
2025/02/21 03:41:12 DEBUG : doChangeNotify("dir/subdir3", 0)
2025/02/21 03:41:12 DEBUG : doChangeNotify("dir/subdir2", 0)
2025/02/21 03:41:12 DEBUG : doChangeNotify("dir/file2.rclone_chunk.001_0qhyg5", 1)
2025/02/21 03:41:12 DEBUG : box root 'rclone-test-bisecop6kaja': Received 3 events, resulting in 3 paths and 3 notifications
2025/02/21 03:41:12 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594019349")
2025/02/21 03:41:13 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594019594")
2025/02/21 03:41:14 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594020347")
2025/02/21 03:41:15 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594021354")
2025/02/21 03:41:15 DEBUG : box root 'rclone-test-bisecop6kaja': ["subdir2"(0)|folder|ITEM_CREATE|308489365451|7aeddf3af375f4e47dba6472c94fee4d42becfc1] ignored due to duplicate EventID
2025/02/21 03:41:16 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594022360")
2025/02/21 03:41:16 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001_0qhyg5"(0)|file|ITEM_UPLOAD|1783735324135|5d3d44d15e68560414fbb09e8f544c85f3116b96] ignored due to duplicate EventID
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594023345")
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001"(1)|file|ITEM_RENAME|1783735324135|72235b302f1a570decb3aeb2215bde64c6d8aec0] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["subdir1"(0)|folder|ITEM_CREATE|308489365621|5b2b7913a273e3b89b1181d5bb53fae8b5373fba] ignored due to old SequenceID ('\x00')
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002_0qhyg5"(0)|file|ITEM_UPLOAD|1783728913469|6cedd81fae4197b1d660d62c21f6f40ec05a9ad4] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1783728913469|22e98971c5871795b02b1dcf52c1ed042630bc7b] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(0)|file|ITEM_UPLOAD|1783726194017|16c752433717625fa1c7d9a18b789519f2d4221c] ignored due to old SequenceID ('\x00')
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': Received 5 events, resulting in 0 paths and 0 notifications
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594024356")
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002_0qhyg5"(0)|file|ITEM_UPLOAD|1783728913469|6cedd81fae4197b1d660d62c21f6f40ec05a9ad4] ignored due to duplicate EventID
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1783728913469|22e98971c5871795b02b1dcf52c1ed042630bc7b] ignored due to duplicate EventID
2025/02/21 03:41:17 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(0)|file|ITEM_UPLOAD|1783726194017|16c752433717625fa1c7d9a18b789519f2d4221c] ignored due to duplicate EventID
2025/02/21 03:41:18 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594024627")
2025/02/21 03:41:18 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(1)|file|ITEM_RENAME|1783728913469|22e98971c5871795b02b1dcf52c1ed042630bc7b] ignored due to duplicate EventID
2025/02/21 03:41:18 INFO  : dir/file4.rclone_chunk.001_0qi6gs: Moved (server-side) to: dir/file4.rclone_chunk.001
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594025349")
2025/02/21 03:41:19 INFO  : dir/file4.rclone_chunk.002_0qi6gs: Moved (server-side) to: dir/file4.rclone_chunk.002
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(0)|file|ITEM_UPLOAD|1783726194017|16c752433717625fa1c7d9a18b789519f2d4221c] ignored due to duplicate EventID
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001_0qi6gs"(0)|file|ITEM_UPLOAD|1783733522009|ecdcd4211eaac3e3927a2ea50a9805bb96fdaf25] added new path ("dir/file4.rclone_chunk.001_0qi6gs") for notify
2025/02/21 03:41:19 DEBUG : doChangeNotify("dir/file4.rclone_chunk.001_0qi6gs", 1)
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': Received 2 events, resulting in 1 paths and 1 notifications
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594026347")
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(0)|file|ITEM_UPLOAD|1783726194017|16c752433717625fa1c7d9a18b789519f2d4221c] ignored due to duplicate EventID
2025/02/21 03:41:19 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001_0qi6gs"(0)|file|ITEM_UPLOAD|1783733522009|ecdcd4211eaac3e3927a2ea50a9805bb96fdaf25] ignored due to duplicate EventID
2025/02/21 03:41:20 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594026595")
2025/02/21 03:41:20 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(0)|file|ITEM_UPLOAD|1783726194017|16c752433717625fa1c7d9a18b789519f2d4221c] ignored due to duplicate EventID
2025/02/21 03:41:20 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001_0qi6gs"(0)|file|ITEM_UPLOAD|1783733522009|ecdcd4211eaac3e3927a2ea50a9805bb96fdaf25] ignored due to duplicate EventID
2025/02/21 03:41:21 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594027346")
2025/02/21 03:41:21 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001_0qi6gs"(0)|file|ITEM_UPLOAD|1783733522009|ecdcd4211eaac3e3927a2ea50a9805bb96fdaf25] ignored due to duplicate EventID
2025/02/21 03:41:21 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.002_0qi6gs"(0)|file|ITEM_UPLOAD|1783730936403|6969af505a4e17e876d38f27a47bfea5bcd131ec] added new path ("dir/file4.rclone_chunk.002_0qi6gs") for notify
2025/02/21 03:41:21 DEBUG : doChangeNotify("dir/file4.rclone_chunk.002_0qi6gs", 1)
2025/02/21 03:41:21 DEBUG : box root 'rclone-test-bisecop6kaja': Received 2 events, resulting in 1 paths and 1 notifications
2025/02/21 03:41:21 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594028349")
2025/02/21 03:41:22 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594028591")
2025/02/21 03:41:23 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594029347")
2025/02/21 03:41:23 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001_0qi6gs"(0)|file|ITEM_UPLOAD|1783733522009|ecdcd4211eaac3e3927a2ea50a9805bb96fdaf25] ignored due to duplicate EventID
2025/02/21 03:41:24 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594030366")
2025/02/21 03:41:25 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594031350")
2025/02/21 03:41:25 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.002_0qi6gs"(0)|file|ITEM_UPLOAD|1783730936403|6969af505a4e17e876d38f27a47bfea5bcd131ec] ignored due to duplicate EventID
2025/02/21 03:41:26 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594032342")
2025/02/21 03:41:26 INFO  : dir/file3.rclone_chunk.001_0qiexx: Moved (server-side) to: dir/file3.rclone_chunk.001
2025/02/21 03:41:26 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001"(1)|file|ITEM_RENAME|1783733522009|d740fe941ba496ff9bdd23db70393d1eacd1e1f3] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:26 DEBUG : box root 'rclone-test-bisecop6kaja': Received 1 events, resulting in 0 paths and 0 notifications
2025/02/21 03:41:26 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594033352")
2025/02/21 03:41:27 INFO  : dir/file3.rclone_chunk.002_0qiexx: Moved (server-side) to: dir/file3.rclone_chunk.002
2025/02/21 03:41:27 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594033593")
2025/02/21 03:41:28 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594034348")
2025/02/21 03:41:28 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4"(0)|file|ITEM_UPLOAD|1783733347062|441661391be8b2d99945807af7de8c094c3f001f] ignored due to old SequenceID ('\x00')
2025/02/21 03:41:28 DEBUG : box root 'rclone-test-bisecop6kaja': Received 1 events, resulting in 0 paths and 0 notifications
2025/02/21 03:41:28 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594035348")
2025/02/21 03:41:29 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594035574")
    fstests.go:935: Try 1/10 waiting for dirChanges and objChanges
2025/02/21 03:41:30 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594036341")
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594037351")
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.001_0qiexx"(0)|file|ITEM_UPLOAD|1783737179227|0ced233abe1cb521e942bbe56894bf7717850351] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.002_0qiexx"(0)|file|ITEM_UPLOAD|1783736475686|55f559233cc7e82a240d75bf29c3e50c647f63ce] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1783736475686|dffa5a676c4177fcb9717462c036abcacd8bd84d] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1783737179227|1ae0609f7b967b0f78fc2792d4f9b5739b132096] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1783730936403|ee840e46329ee7e64ae44986643678301182081d] ignored due to old SequenceID ('\x01')
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': Received 5 events, resulting in 0 paths and 0 notifications
2025/02/21 03:41:31 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594038346")
2025/02/21 03:41:32 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594038603")
    fstests.go:935: Try 2/10 waiting for dirChanges and objChanges
2025/02/21 03:41:33 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594039351")
2025/02/21 03:41:34 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594040363")
2025/02/21 03:41:34 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.002_0qiexx"(0)|file|ITEM_UPLOAD|1783736475686|55f559233cc7e82a240d75bf29c3e50c647f63ce] ignored due to duplicate EventID
2025/02/21 03:41:34 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.002"(1)|file|ITEM_RENAME|1783736475686|dffa5a676c4177fcb9717462c036abcacd8bd84d] ignored due to duplicate EventID
2025/02/21 03:41:35 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594041347")
2025/02/21 03:41:35 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.001"(1)|file|ITEM_RENAME|1783737179227|1ae0609f7b967b0f78fc2792d4f9b5739b132096] ignored due to duplicate EventID
2025/02/21 03:41:35 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.002"(1)|file|ITEM_RENAME|1783730936403|ee840e46329ee7e64ae44986643678301182081d] ignored due to duplicate EventID
    fstests.go:935: Try 3/10 waiting for dirChanges and objChanges
2025/02/21 03:41:36 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594042354")
2025/02/21 03:41:36 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3"(0)|file|ITEM_UPLOAD|1783730308372|05094df0ed8a41abc8f7fd9991d51f95d8550781] ignored due to old SequenceID ('\x00')
2025/02/21 03:41:36 DEBUG : box root 'rclone-test-bisecop6kaja': Received 1 events, resulting in 0 paths and 0 notifications
2025/02/21 03:41:36 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594043374")
2025/02/21 03:41:37 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594043604")
2025/02/21 03:41:38 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594044347")
    fstests.go:935: Try 4/10 waiting for dirChanges and objChanges
2025/02/21 03:41:39 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594045341")
2025/02/21 03:41:40 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594046344")
2025/02/21 03:41:41 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594047350")
    fstests.go:935: Try 5/10 waiting for dirChanges and objChanges
2025/02/21 03:41:42 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594048349")
2025/02/21 03:41:43 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594049348")
2025/02/21 03:41:44 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594050355")
    fstests.go:935: Try 6/10 waiting for dirChanges and objChanges
2025/02/21 03:41:45 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594051350")
2025/02/21 03:41:46 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594052354")
2025/02/21 03:41:47 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594053353")
    fstests.go:935: Try 7/10 waiting for dirChanges and objChanges
2025/02/21 03:41:48 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594054368")
2025/02/21 03:41:49 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594055348")
2025/02/21 03:41:50 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594056349")
    fstests.go:935: Try 8/10 waiting for dirChanges and objChanges
2025/02/21 03:41:51 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594057360")
2025/02/21 03:41:52 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594058350")
2025/02/21 03:41:53 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594059354")
    fstests.go:935: Try 9/10 waiting for dirChanges and objChanges
2025/02/21 03:41:54 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594060349")
2025/02/21 03:41:55 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594061350")
2025/02/21 03:41:56 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594062355")
    fstests.go:939: map[dir:{} dir/subdir2:{} dir/subdir3:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or 
        map[dir/file2.rclone_chunk.001_0qhyg5:{} dir/file4.rclone_chunk.001_0qi6gs:{} dir/file4.rclone_chunk.002_0qi6gs:{}] does not contain [dir/file2 dir/file4 dir/file3]
2025/02/21 03:41:57 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594063357")
2025/02/21 03:41:58 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594064351")
2025/02/21 03:41:59 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594065347")
2025/02/21 03:42:00 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594066360")
2025/02/21 03:42:01 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594067346")
2025/02/21 03:42:02 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594068351")
2025/02/21 03:42:03 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594069347")
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594070351")
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1783728913469|5dedebdccf6b265af21acffcd90ecdbc1fb4e3ed] added old path ("dir/file2.rclone_chunk.002") for notify
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1783735324135|94638e6651c9b73b5a02f6e3a2c91d05e605773e] added old path ("dir/file2.rclone_chunk.001") for notify
2025/02/21 03:42:04 DEBUG : doChangeNotify("dir/file2", 1)
2025/02/21 03:42:04 DEBUG : doChangeNotify("dir/file2", 1)
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': Received 2 events, resulting in 2 paths and 2 notifications
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594071350")
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1783728913469|5dedebdccf6b265af21acffcd90ecdbc1fb4e3ed] ignored due to duplicate EventID
2025/02/21 03:42:04 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1783735324135|94638e6651c9b73b5a02f6e3a2c91d05e605773e] ignored due to duplicate EventID
2025/02/21 03:42:05 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594071602")
2025/02/21 03:42:05 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1783728913469|5dedebdccf6b265af21acffcd90ecdbc1fb4e3ed] ignored due to duplicate EventID
2025/02/21 03:42:05 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1783735324135|94638e6651c9b73b5a02f6e3a2c91d05e605773e] ignored due to duplicate EventID
2025/02/21 03:42:05 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4"(1)|file|ITEM_TRASH|1783733347062|da15269f708e800711a5f45dda0282ae08cbd40a] added old path ("dir/file4") for notify
2025/02/21 03:42:05 DEBUG : doChangeNotify("dir/file4", 1)
2025/02/21 03:42:05 DEBUG : box root 'rclone-test-bisecop6kaja': Received 3 events, resulting in 1 paths and 1 notifications
2025/02/21 03:42:05 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594072345")
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594072588")
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1783728913469|5dedebdccf6b265af21acffcd90ecdbc1fb4e3ed] ignored due to duplicate EventID
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1783735324135|94638e6651c9b73b5a02f6e3a2c91d05e605773e] ignored due to duplicate EventID
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4"(1)|file|ITEM_TRASH|1783733347062|da15269f708e800711a5f45dda0282ae08cbd40a] ignored due to duplicate EventID
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1783733522009|835751df25b574a9945004b083001d5b0a0c4265] added old path ("dir/file4.rclone_chunk.001") for notify
2025/02/21 03:42:06 DEBUG : doChangeNotify("dir/file4", 1)
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': Received 4 events, resulting in 1 paths and 1 notifications
2025/02/21 03:42:06 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594073345")
2025/02/21 03:42:07 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594073595")
2025/02/21 03:42:08 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594074354")
2025/02/21 03:42:08 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.002"(2)|file|ITEM_TRASH|1783728913469|5dedebdccf6b265af21acffcd90ecdbc1fb4e3ed] ignored due to duplicate EventID
2025/02/21 03:42:08 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2.rclone_chunk.001"(2)|file|ITEM_TRASH|1783735324135|94638e6651c9b73b5a02f6e3a2c91d05e605773e] ignored due to duplicate EventID
2025/02/21 03:42:09 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594075348")
2025/02/21 03:42:09 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4"(1)|file|ITEM_TRASH|1783733347062|da15269f708e800711a5f45dda0282ae08cbd40a] ignored due to duplicate EventID
2025/02/21 03:42:10 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594076354")
2025/02/21 03:42:10 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.001"(2)|file|ITEM_TRASH|1783733522009|835751df25b574a9945004b083001d5b0a0c4265] ignored due to duplicate EventID
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594077351")
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file4.rclone_chunk.002"(2)|file|ITEM_TRASH|1783730936403|b36f8812b8f8775f7be1ec636db4e05740fddf12] old parent not cached
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(1)|file|ITEM_TRASH|1783726194017|ba9456e9a048a4f033e33b509a06bcf999d9f09f] old parent not cached
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3"(1)|file|ITEM_TRASH|1783730308372|6a78eef5a1dae8b53eb04e82ab00173dd9497433] old parent not cached
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1783737179227|a4e2199edfe58b68d0d8cf9537d192eb3950c351] old parent not cached
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["subdir1"(1)|folder|ITEM_TRASH|308489365621|de8f42e6f494e2ac89e5244daec2d1d8bf30934a] old parent not cached
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1783736475686|7c05394b0b477163fa71d5a5270b7f4313f5df59] old parent not cached
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': Received 6 events, resulting in 0 paths and 0 notifications
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': Checking for changes on remote (next_stream_position: "30401037594078363")
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file2"(1)|file|ITEM_TRASH|1783726194017|ba9456e9a048a4f033e33b509a06bcf999d9f09f] ignored due to duplicate EventID
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3"(1)|file|ITEM_TRASH|1783730308372|6a78eef5a1dae8b53eb04e82ab00173dd9497433] ignored due to duplicate EventID
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.001"(2)|file|ITEM_TRASH|1783737179227|a4e2199edfe58b68d0d8cf9537d192eb3950c351] ignored due to duplicate EventID
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["subdir1"(1)|folder|ITEM_TRASH|308489365621|de8f42e6f494e2ac89e5244daec2d1d8bf30934a] ignored due to duplicate EventID
2025/02/21 03:42:11 DEBUG : box root 'rclone-test-bisecop6kaja': ["file3.rclone_chunk.002"(2)|file|ITEM_TRASH|1783736475686|7c05394b0b477163fa71d5a5270b7f4313f5df59] ignored due to duplicate EventID
2025/02/21 03:42:12 DEBUG : box root 'rclone-test-bisecop6kaja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
2025/02/21 03:42:12 ERROR : : error listing: directory not found
2025/02/21 03:42:13 DEBUG : box root 'rclone-test-bisecop6kaja': Ignoring "Shared folder — ForNick" - unknown type "web_link"
--- FAIL: TestIntegration (74.88s)
    --- FAIL: TestIntegration/FsMkdir (72.30s)
        --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (69.84s)
FAIL
exit status 1
FAIL	github.com/rclone/rclone/backend/chunker	74.913s
"go test -v -timeout 1h0m0s -remote TestChunkerChunk50bBox: -verbose -size-limit 1024 -test.run '^TestIntegration$/^FsMkdir$/^FsChangeNotify$'" - Finished ERROR in 1m17.774170457s (try 2/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]