"go test -v -timeout 1h0m0s -remote TestBox: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestBox:" 2025/03/17 09:57:02 DEBUG : Creating backend with remote "TestBox:rclone-test-borejoq0woro" 2025/03/17 09:57:02 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/17 09:57:02 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsCheckWrap fstests.go:479: Not a wrapping Fs === RUN TestIntegration/FsCommand fstests.go:507: No commands in this remote === RUN TestIntegration/FsRmdirNotFound 2025/03/17 09:57:03 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 09:57:04 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsString === RUN TestIntegration/FsName === RUN TestIntegration/FsRoot === RUN TestIntegration/FsRmdirEmpty === RUN TestIntegration/FsMkdir 2025/03/17 09:57:06 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/17 09:57:07 INFO : dir/subdir: Making directory 2025/03/17 09:57:10 INFO : dir/subdir: Removing directory 2025/03/17 09:57:12 INFO : dir: Removing directory === RUN TestIntegration/FsMkdir/FsListEmpty === RUN TestIntegration/FsMkdir/FsListDirEmpty === RUN TestIntegration/FsMkdir/FsListRDirEmpty fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsListDirNotFound 2025/03/17 09:57:14 ERROR : does not exist: error listing: directory not found === RUN TestIntegration/FsMkdir/FsListRDirNotFound fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsEncoding === RUN TestIntegration/FsMkdir/FsEncoding/control_chars fstests.go:707: testing "␀␁␂␃␄␅␆␇␈␉␊␋␌␍␎␏␐␑␒␓␔␕␖␗␘␙␚␛␜␝␞␟␡" === RUN TestIntegration/FsMkdir/FsEncoding/dot fstests.go:707: testing "．" === RUN TestIntegration/FsMkdir/FsEncoding/dot_dot fstests.go:707: testing "．．" === RUN TestIntegration/FsMkdir/FsEncoding/punctuation fstests.go:707: testing "!\"#$%&'()*+,-.／:;<=>?@[\\]^_`{|}~" === RUN TestIntegration/FsMkdir/FsEncoding/leading_space fstests.go:707: testing " leading space" === RUN TestIntegration/FsMkdir/FsEncoding/leading_tilde fstests.go:707: testing "~leading tilde" === RUN TestIntegration/FsMkdir/FsEncoding/leading_CR fstests.go:707: testing "␍leading CR" === RUN TestIntegration/FsMkdir/FsEncoding/leading_LF fstests.go:707: testing "␊leading LF" === RUN TestIntegration/FsMkdir/FsEncoding/leading_HT fstests.go:707: testing "␉leading HT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_VT fstests.go:707: testing "␋leading VT" === RUN TestIntegration/FsMkdir/FsEncoding/leading_dot fstests.go:707: testing ".leading dot" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_space fstests.go:707: testing "trailing space " === RUN TestIntegration/FsMkdir/FsEncoding/trailing_CR fstests.go:707: testing "trailing CR␍" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_LF fstests.go:707: testing "trailing LF␊" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_HT fstests.go:707: testing "trailing HT␉" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_VT fstests.go:707: testing "trailing VT␋" === RUN TestIntegration/FsMkdir/FsEncoding/trailing_dot fstests.go:707: testing "trailing dot." === RUN TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 fstests.go:707: testing "invalid utf-8\xfe" === RUN TestIntegration/FsMkdir/FsEncoding/URL_encoding fstests.go:707: testing "test%46.txt" === RUN TestIntegration/FsMkdir/FsNewObjectNotFound === RUN TestIntegration/FsMkdir/FsPutError === RUN TestIntegration/FsMkdir/FsPutZeroLength === RUN TestIntegration/FsMkdir/FsOpenWriterAt fstests.go:786: FS has no OpenWriterAt interface === RUN TestIntegration/FsMkdir/FsOpenChunkWriter fstests.go:819: FS has no OpenChunkWriter interface === RUN TestIntegration/FsMkdir/FsChangeNotify 2025/03/17 09:59:19 INFO : dir: Making directory 2025/03/17 09:59:20 INFO : dir/subdir1: Making directory 2025/03/17 09:59:21 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690307389") 2025/03/17 09:59:21 INFO : dir/subdir3: Making directory 2025/03/17 09:59:21 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir"(0)|folder|ITEM_CREATE|312096819741|b0f9dbb83b6fc1fb776f8fcd43ebe69b460e1734] new parent not found 2025/03/17 09:59:21 DEBUG : box root 'rclone-test-borejoq0woro': [" \" ' @ < > & ? + ≠"(0)|folder|ITEM_CREATE|312098596480|47ec0be950694eae26c669f8f0c8fb854e9e8176] added new path ("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠") for notify 2025/03/17 09:59:21 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠", 0) 2025/03/17 09:59:21 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠", 0 2025/03/17 09:59:21 DEBUG : box root 'rclone-test-borejoq0woro': Received 2 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:21 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690308612") 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690308840") 2025/03/17 09:59:22 INFO : dir/subdir2: Making directory 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt.rclone_chunk.001_9o0e0r"(0)|file|ITEM_UPLOAD|1805536665548|1a4c77425073e00f9e00379f766a85d862bda023] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt.rclone_chunk.001_9o0evk"(0)|file|ITEM_UPLOAD|1805536571967|5f98a5d8b5dfcec7031212f7577a6978d6583c50] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt.rclone_chunk.001_9o0e1o"(0)|file|ITEM_UPLOAD|1805528133529|8c89aefd92dbef408edbf0bccd6fb0e5b3881ff0] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt.rclone_chunk.001_9o0e5p"(0)|file|ITEM_UPLOAD|1805527918908|562fb8820cbf8a6630661ad6ef444df2f62c4427] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt"(1)|file|ITEM_RENAME|1805527918908|833cb00c468a3627632298ea8f92a97edee2d430] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt"(1)|file|ITEM_RENAME|1805536571967|356a2fcf1e0183e5bb290584c13e64ae6bfd5157] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt"(1)|file|ITEM_RENAME|1805536665548|95828e63bb6bda37a93838ff9d0da9f73f010678] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt"(1)|file|ITEM_RENAME|1805528133529|e659aed34ee5a49bbb217e73552f368641d22ee9] new parent not found 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': Received 9 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:22 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690309614") 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt.rclone_chunk.001_9o0e0r"(0)|file|ITEM_UPLOAD|1805536665548|1a4c77425073e00f9e00379f766a85d862bda023] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt.rclone_chunk.001_9o0evk"(0)|file|ITEM_UPLOAD|1805536571967|5f98a5d8b5dfcec7031212f7577a6978d6583c50] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt.rclone_chunk.001_9o0e1o"(0)|file|ITEM_UPLOAD|1805528133529|8c89aefd92dbef408edbf0bccd6fb0e5b3881ff0] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt.rclone_chunk.001_9o0e5p"(0)|file|ITEM_UPLOAD|1805527918908|562fb8820cbf8a6630661ad6ef444df2f62c4427] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt"(1)|file|ITEM_RENAME|1805527918908|833cb00c468a3627632298ea8f92a97edee2d430] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt"(1)|file|ITEM_RENAME|1805536571967|356a2fcf1e0183e5bb290584c13e64ae6bfd5157] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt"(1)|file|ITEM_RENAME|1805536665548|95828e63bb6bda37a93838ff9d0da9f73f010678] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt"(1)|file|ITEM_RENAME|1805528133529|e659aed34ee5a49bbb217e73552f368641d22ee9] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["zero-length-file"(1)|file|ITEM_TRASH|1805537596550|6114644215e2db752cc4ed50331055f4a92c0c98] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt.rclone_chunk.001_9o0i6z"(0)|file|ITEM_UPLOAD|1805536856808|9282d9cc06377d305849ba9965d847a8eb758155] new parent not found 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001_9o0iar"(0)|file|ITEM_UPLOAD|1805536617167|9b35fe1f70c848fa939135bc95f39ce77025b0ee] new parent not found 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': Received 11 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690309862") 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt.rclone_chunk.001_9o0e0r"(0)|file|ITEM_UPLOAD|1805536665548|1a4c77425073e00f9e00379f766a85d862bda023] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt.rclone_chunk.001_9o0evk"(0)|file|ITEM_UPLOAD|1805536571967|5f98a5d8b5dfcec7031212f7577a6978d6583c50] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt.rclone_chunk.001_9o0e1o"(0)|file|ITEM_UPLOAD|1805528133529|8c89aefd92dbef408edbf0bccd6fb0e5b3881ff0] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt.rclone_chunk.001_9o0e5p"(0)|file|ITEM_UPLOAD|1805527918908|562fb8820cbf8a6630661ad6ef444df2f62c4427] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt"(1)|file|ITEM_RENAME|1805527918908|833cb00c468a3627632298ea8f92a97edee2d430] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt"(1)|file|ITEM_RENAME|1805536571967|356a2fcf1e0183e5bb290584c13e64ae6bfd5157] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt"(1)|file|ITEM_RENAME|1805536665548|95828e63bb6bda37a93838ff9d0da9f73f010678] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt"(1)|file|ITEM_RENAME|1805528133529|e659aed34ee5a49bbb217e73552f368641d22ee9] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["zero-length-file"(1)|file|ITEM_TRASH|1805537596550|6114644215e2db752cc4ed50331055f4a92c0c98] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt.rclone_chunk.001_9o0i6z"(0)|file|ITEM_UPLOAD|1805536856808|9282d9cc06377d305849ba9965d847a8eb758155] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001_9o0iar"(0)|file|ITEM_UPLOAD|1805536617167|9b35fe1f70c848fa939135bc95f39ce77025b0ee] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file20.txt.rclone_chunk.001_9o0ips"(0)|file|ITEM_UPLOAD|1805535810433|873f3ecb8b3323b2231a4b9f51f5cf6115f62370] new parent not found 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy5.txt.rclone_chunk.001_9o0i1e"(0)|file|ITEM_UPLOAD|1805513259811|b8968bb0cadd92dbed54f209902d075afa256f58] new parent not found 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir1"(0)|folder|ITEM_CREATE|312098459302|7a9114963d9ab0f442b3acd986a972429510a5da] added new path ("dir/subdir1") for notify 2025/03/17 09:59:23 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': Received 14 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690310183") 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt.rclone_chunk.001_9o0e0r"(0)|file|ITEM_UPLOAD|1805536665548|1a4c77425073e00f9e00379f766a85d862bda023] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt.rclone_chunk.001_9o0evk"(0)|file|ITEM_UPLOAD|1805536571967|5f98a5d8b5dfcec7031212f7577a6978d6583c50] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt.rclone_chunk.001_9o0e1o"(0)|file|ITEM_UPLOAD|1805528133529|8c89aefd92dbef408edbf0bccd6fb0e5b3881ff0] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt.rclone_chunk.001_9o0e5p"(0)|file|ITEM_UPLOAD|1805527918908|562fb8820cbf8a6630661ad6ef444df2f62c4427] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt"(1)|file|ITEM_RENAME|1805527918908|833cb00c468a3627632298ea8f92a97edee2d430] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt"(1)|file|ITEM_RENAME|1805536571967|356a2fcf1e0183e5bb290584c13e64ae6bfd5157] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt"(1)|file|ITEM_RENAME|1805536665548|95828e63bb6bda37a93838ff9d0da9f73f010678] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt"(1)|file|ITEM_RENAME|1805528133529|e659aed34ee5a49bbb217e73552f368641d22ee9] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["zero-length-file"(1)|file|ITEM_TRASH|1805537596550|6114644215e2db752cc4ed50331055f4a92c0c98] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt.rclone_chunk.001_9o0i6z"(0)|file|ITEM_UPLOAD|1805536856808|9282d9cc06377d305849ba9965d847a8eb758155] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001_9o0iar"(0)|file|ITEM_UPLOAD|1805536617167|9b35fe1f70c848fa939135bc95f39ce77025b0ee] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file20.txt.rclone_chunk.001_9o0ips"(0)|file|ITEM_UPLOAD|1805535810433|873f3ecb8b3323b2231a4b9f51f5cf6115f62370] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy5.txt.rclone_chunk.001_9o0i1e"(0)|file|ITEM_UPLOAD|1805513259811|b8968bb0cadd92dbed54f209902d075afa256f58] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir1"(0)|folder|ITEM_CREATE|312098459302|7a9114963d9ab0f442b3acd986a972429510a5da] ignored due to duplicate EventID 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir3"(0)|folder|ITEM_CREATE|312099884477|b873dc5e0e8824279673dc5323343cc6ee003026] added new path ("dir/subdir3") for notify 2025/03/17 09:59:23 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': Received 15 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:23 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690310504") 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt.rclone_chunk.001_9o0e0r"(0)|file|ITEM_UPLOAD|1805536665548|1a4c77425073e00f9e00379f766a85d862bda023] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690310816") 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt.rclone_chunk.001_9o0evk"(0)|file|ITEM_UPLOAD|1805536571967|5f98a5d8b5dfcec7031212f7577a6978d6583c50] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt.rclone_chunk.001_9o0e1o"(0)|file|ITEM_UPLOAD|1805528133529|8c89aefd92dbef408edbf0bccd6fb0e5b3881ff0] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt.rclone_chunk.001_9o0e5p"(0)|file|ITEM_UPLOAD|1805527918908|562fb8820cbf8a6630661ad6ef444df2f62c4427] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690311048") 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt"(1)|file|ITEM_RENAME|1805527918908|833cb00c468a3627632298ea8f92a97edee2d430] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt"(1)|file|ITEM_RENAME|1805536571967|356a2fcf1e0183e5bb290584c13e64ae6bfd5157] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt"(1)|file|ITEM_RENAME|1805536665548|95828e63bb6bda37a93838ff9d0da9f73f010678] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt"(1)|file|ITEM_RENAME|1805528133529|e659aed34ee5a49bbb217e73552f368641d22ee9] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["zero-length-file"(1)|file|ITEM_TRASH|1805537596550|6114644215e2db752cc4ed50331055f4a92c0c98] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt.rclone_chunk.001_9o0i6z"(0)|file|ITEM_UPLOAD|1805536856808|9282d9cc06377d305849ba9965d847a8eb758155] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001_9o0iar"(0)|file|ITEM_UPLOAD|1805536617167|9b35fe1f70c848fa939135bc95f39ce77025b0ee] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file20.txt.rclone_chunk.001_9o0ips"(0)|file|ITEM_UPLOAD|1805535810433|873f3ecb8b3323b2231a4b9f51f5cf6115f62370] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy5.txt.rclone_chunk.001_9o0i1e"(0)|file|ITEM_UPLOAD|1805513259811|b8968bb0cadd92dbed54f209902d075afa256f58] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir1"(0)|folder|ITEM_CREATE|312098459302|7a9114963d9ab0f442b3acd986a972429510a5da] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir3"(0)|folder|ITEM_CREATE|312099884477|b873dc5e0e8824279673dc5323343cc6ee003026] ignored due to duplicate EventID 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file20.txt"(1)|file|ITEM_RENAME|1805535810433|c6cb322b661b448af521310e34116b53c18b3b06] new parent not found 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy5.txt"(1)|file|ITEM_RENAME|1805513259811|b136d9feb8a97325f9fdf56345343d989d17750e] new parent not found 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt"(1)|file|ITEM_RENAME|1805536856808|173c6ad116a8f88311a2d670710c728d3ff5999c] new parent not found 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': Received 14 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:24 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690311616") 2025/03/17 09:59:25 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy3.txt"(1)|file|ITEM_RENAME|1805527918908|833cb00c468a3627632298ea8f92a97edee2d430] ignored due to duplicate EventID 2025/03/17 09:59:25 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690311884") 2025/03/17 09:59:25 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy1.txt"(1)|file|ITEM_RENAME|1805536571967|356a2fcf1e0183e5bb290584c13e64ae6bfd5157] ignored due to duplicate EventID 2025/03/17 09:59:25 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy4.txt"(1)|file|ITEM_RENAME|1805536665548|95828e63bb6bda37a93838ff9d0da9f73f010678] ignored due to duplicate EventID 2025/03/17 09:59:25 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy2.txt"(1)|file|ITEM_RENAME|1805528133529|e659aed34ee5a49bbb217e73552f368641d22ee9] ignored due to duplicate EventID 2025/03/17 09:59:25 DEBUG : box root 'rclone-test-borejoq0woro': ["zero-length-file"(1)|file|ITEM_TRASH|1805537596550|6114644215e2db752cc4ed50331055f4a92c0c98] ignored due to duplicate EventID 2025/03/17 09:59:26 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690312604") 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690313618") 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt.rclone_chunk.001_9o0i6z"(0)|file|ITEM_UPLOAD|1805536856808|9282d9cc06377d305849ba9965d847a8eb758155] ignored due to duplicate EventID 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001_9o0iar"(0)|file|ITEM_UPLOAD|1805536617167|9b35fe1f70c848fa939135bc95f39ce77025b0ee] ignored due to duplicate EventID 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': ["file20.txt.rclone_chunk.001_9o0ips"(0)|file|ITEM_UPLOAD|1805535810433|873f3ecb8b3323b2231a4b9f51f5cf6115f62370] ignored due to duplicate EventID 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy5.txt.rclone_chunk.001_9o0i1e"(0)|file|ITEM_UPLOAD|1805513259811|b8968bb0cadd92dbed54f209902d075afa256f58] ignored due to duplicate EventID 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir1"(0)|folder|ITEM_CREATE|312098459302|7a9114963d9ab0f442b3acd986a972429510a5da] ignored due to duplicate EventID 2025/03/17 09:59:27 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir3"(0)|folder|ITEM_CREATE|312099884477|b873dc5e0e8824279673dc5323343cc6ee003026] ignored due to duplicate EventID 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690314612") 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["file20.txt"(1)|file|ITEM_RENAME|1805535810433|c6cb322b661b448af521310e34116b53c18b3b06] ignored due to duplicate EventID 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.copy5.txt"(1)|file|ITEM_RENAME|1805513259811|b136d9feb8a97325f9fdf56345343d989d17750e] ignored due to duplicate EventID 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt"(1)|file|ITEM_RENAME|1805536856808|173c6ad116a8f88311a2d670710c728d3ff5999c] ignored due to duplicate EventID 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002_9o0iar"(0)|file|ITEM_UPLOAD|1805534384803|2ceeea2ab4d922799597344a482521df885ec82d] new parent not found 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir2"(0)|folder|ITEM_CREATE|312096774369|0ead4a4f8b04cdd35e9eda87a7d1092e4f80455b] added new path ("dir/subdir2") for notify 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.003_9o0iar"(0)|file|ITEM_UPLOAD|1805512912761|8f8a8712989e66c2ebd8b3819b8cbf1cb0b24ac6] new parent not found 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1805534384803|324df10998cab4e8f256f560924e0dcd40201735] new parent not found 2025/03/17 09:59:28 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': Received 7 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:28 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690315603") 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002_9o0iar"(0)|file|ITEM_UPLOAD|1805534384803|2ceeea2ab4d922799597344a482521df885ec82d] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir2"(0)|folder|ITEM_CREATE|312096774369|0ead4a4f8b04cdd35e9eda87a7d1092e4f80455b] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.003_9o0iar"(0)|file|ITEM_UPLOAD|1805512912761|8f8a8712989e66c2ebd8b3819b8cbf1cb0b24ac6] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1805534384803|324df10998cab4e8f256f560924e0dcd40201735] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["file4"(0)|file|ITEM_UPLOAD|1805536783148|accd2c658858a5188c5417b554424646afe281b0] added new path ("dir/file4") for notify 2025/03/17 09:59:29 DEBUG : doChangeNotify("dir/file4", 1) 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': Received 5 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690315842") 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002_9o0iar"(0)|file|ITEM_UPLOAD|1805534384803|2ceeea2ab4d922799597344a482521df885ec82d] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir2"(0)|folder|ITEM_CREATE|312096774369|0ead4a4f8b04cdd35e9eda87a7d1092e4f80455b] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.003_9o0iar"(0)|file|ITEM_UPLOAD|1805512912761|8f8a8712989e66c2ebd8b3819b8cbf1cb0b24ac6] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1805534384803|324df10998cab4e8f256f560924e0dcd40201735] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': ["file4"(0)|file|ITEM_UPLOAD|1805536783148|accd2c658858a5188c5417b554424646afe281b0] ignored due to duplicate EventID 2025/03/17 09:59:29 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690316099") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/17 09:59:30 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690316619") 2025/03/17 09:59:30 DEBUG : box root 'rclone-test-borejoq0woro': ["subdir2"(0)|folder|ITEM_CREATE|312096774369|0ead4a4f8b04cdd35e9eda87a7d1092e4f80455b] ignored due to duplicate EventID 2025/03/17 09:59:30 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.003_9o0iar"(0)|file|ITEM_UPLOAD|1805512912761|8f8a8712989e66c2ebd8b3819b8cbf1cb0b24ac6] ignored due to duplicate EventID 2025/03/17 09:59:30 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1805534384803|324df10998cab4e8f256f560924e0dcd40201735] ignored due to duplicate EventID 2025/03/17 09:59:30 DEBUG : box root 'rclone-test-borejoq0woro': ["file4"(0)|file|ITEM_UPLOAD|1805536783148|accd2c658858a5188c5417b554424646afe281b0] ignored due to duplicate EventID 2025/03/17 09:59:31 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690317606") 2025/03/17 09:59:31 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.002"(1)|file|ITEM_RENAME|1805534384803|324df10998cab4e8f256f560924e0dcd40201735] ignored due to duplicate EventID 2025/03/17 09:59:32 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690318602") 2025/03/17 09:59:32 DEBUG : box root 'rclone-test-borejoq0woro': ["file4"(0)|file|ITEM_UPLOAD|1805536783148|accd2c658858a5188c5417b554424646afe281b0] ignored due to duplicate EventID fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/17 09:59:33 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690319604") 2025/03/17 09:59:33 DEBUG : box root 'rclone-test-borejoq0woro': ["file4"(0)|file|ITEM_UPLOAD|1805536783148|accd2c658858a5188c5417b554424646afe281b0] ignored due to duplicate EventID 2025/03/17 09:59:33 DEBUG : box root 'rclone-test-borejoq0woro': ["dir"(0)|folder|ITEM_CREATE|312096717351|b4451eab3f807bb1c29b5d5f8ebf6e887a76d4e0] added new path ("dir") for notify 2025/03/17 09:59:33 DEBUG : doChangeNotify("dir", 0) 2025/03/17 09:59:33 DEBUG : box root 'rclone-test-borejoq0woro': Received 2 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:33 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690320609") 2025/03/17 09:59:34 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690320843") 2025/03/17 09:59:35 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690321606") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/17 09:59:36 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690322609") 2025/03/17 09:59:37 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690323609") 2025/03/17 09:59:37 DEBUG : box root 'rclone-test-borejoq0woro': ["dir"(0)|folder|ITEM_CREATE|312096717351|b4451eab3f807bb1c29b5d5f8ebf6e887a76d4e0] ignored due to duplicate EventID 2025/03/17 09:59:38 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690324607") 2025/03/17 09:59:38 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST"(0)|file|ITEM_UPLOAD|1805514667163|354c3772d37639147d5cd1edc0227b128db10592] new parent not found 2025/03/17 09:59:38 DEBUG : box root 'rclone-test-borejoq0woro': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:38 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690325604") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/17 09:59:39 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690325827") 2025/03/17 09:59:40 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690326609") 2025/03/17 09:59:40 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test.rclone_chunk.001_9o0sms"(0)|file|ITEM_UPLOAD|1805521710784|a521920974e5090f23c8cb30bc5fe39018e255a1] new parent not found 2025/03/17 09:59:40 DEBUG : box root 'rclone-test-borejoq0woro': Received 1 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:40 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690327606") 2025/03/17 09:59:41 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690327831") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/17 09:59:42 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690328622") 2025/03/17 09:59:43 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690329611") 2025/03/17 09:59:44 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690330614") 2025/03/17 09:59:44 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test.rclone_chunk.001_9o0sms"(0)|file|ITEM_UPLOAD|1805521710784|a521920974e5090f23c8cb30bc5fe39018e255a1] ignored due to duplicate EventID fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/17 09:59:45 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690331621") 2025/03/17 09:59:45 DEBUG : box root 'rclone-test-borejoq0woro': ["file2"(0)|file|ITEM_UPLOAD|1805537099462|f21df22e4fe160a6f0eaeed336ab521866093657] added new path ("dir/file2") for notify 2025/03/17 09:59:45 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/17 09:59:45 DEBUG : box root 'rclone-test-borejoq0woro': Received 1 events, resulting in 1 paths and 1 notifications 2025/03/17 09:59:45 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690332648") 2025/03/17 09:59:46 DEBUG : box root 'rclone-test-borejoq0woro': ["zero-length-file"(0)|file|ITEM_UPLOAD|1805537596550|e81b5d47f95ecf4befe669a532865a65e256cefe] added new path ("zero-length-file") for notify 2025/03/17 09:59:46 DEBUG : box root 'rclone-test-borejoq0woro': ["file3"(0)|file|ITEM_UPLOAD|1805536175489|c565ff272a7ceab02e150f41160d27a14cca85ab] added new path ("dir/file3") for notify 2025/03/17 09:59:46 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/17 09:59:46 DEBUG : doChangeNotify("dir/file3", 1) 2025/03/17 09:59:46 DEBUG : box root 'rclone-test-borejoq0woro': Received 2 events, resulting in 2 paths and 2 notifications 2025/03/17 09:59:46 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690332885") 2025/03/17 09:59:46 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690333123") 2025/03/17 09:59:47 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690333615") 2025/03/17 09:59:47 DEBUG : box root 'rclone-test-borejoq0woro': ["file3"(0)|file|ITEM_UPLOAD|1805536175489|c565ff272a7ceab02e150f41160d27a14cca85ab] ignored due to duplicate EventID 2025/03/17 09:59:48 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690334629") 2025/03/17 09:59:49 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690335627") 2025/03/17 09:59:50 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690336613") 2025/03/17 09:59:51 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690337616") 2025/03/17 09:59:52 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690338615") 2025/03/17 09:59:53 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690339622") 2025/03/17 09:59:53 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test"(1)|file|ITEM_RENAME|1805521710784|57781b0b1b7fae3bcde67c7c0779d737d20cac9c] new parent not found 2025/03/17 09:59:53 DEBUG : box root 'rclone-test-borejoq0woro': Received 2 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:53 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690340614") 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001"(1)|file|ITEM_RENAME|1805536617167|a273ad021eca36c7f1f4365ffea1c796b8b72e4f] new parent not found 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt"(1)|file|ITEM_RENAME|1805527506916|ff0bb8362df68d7dc443b8689bcee175e4d4fdfe] new parent not found 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test.rclone_chunk.001_9o1b3p"(0)|file|ITEM_UPLOAD|1805529578217|2029290aab6a4e96a879f6efaa7e95d48b4e7415] new parent not found 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test.rclone_chunk.001_9o0yit"(0)|file|ITEM_UPLOAD|1805534895985|a92fa226e461c5e2af7759d59ce4a5810ba4e562] new parent not found 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': Received 6 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690340859") 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001"(1)|file|ITEM_RENAME|1805536617167|a273ad021eca36c7f1f4365ffea1c796b8b72e4f] ignored due to duplicate EventID 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["file1.txt"(1)|file|ITEM_RENAME|1805527506916|ff0bb8362df68d7dc443b8689bcee175e4d4fdfe] ignored due to duplicate EventID 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test.rclone_chunk.001_9o1b3p"(0)|file|ITEM_UPLOAD|1805529578217|2029290aab6a4e96a879f6efaa7e95d48b4e7415] ignored due to duplicate EventID 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test.rclone_chunk.001_9o0yit"(0)|file|ITEM_UPLOAD|1805534895985|a92fa226e461c5e2af7759d59ce4a5810ba4e562] ignored due to duplicate EventID 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["modtime_write_test"(2)|file|ITEM_TRASH|1805534895985|ba0159425c19bd08b4040fb4453d8820fcb398d3] ignored due to duplicate EventID 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["file4"(1)|file|ITEM_TRASH|1805536783148|a7b99be5450df3d26e79c0794ec44ca0e692ebec] ignored due to duplicate EventID 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': Received 7 events, resulting in 0 paths and 0 notifications 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690341121") 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': Checking for changes on remote (next_stream_position: "30401039690341386") === RUN TestIntegration/FsMkdir/FsPutFiles 2025/03/17 09:59:54 DEBUG : box root 'rclone-test-borejoq0woro': ["RCLONE_TEST.rclone_chunk.001"(1)|file|ITEM_RENAME|1805536617167|a273ad021eca36c7f1f4365ffea1c796b8b72e4f] ignored due to duplicate EventID === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListR === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot 2025/03/17 10:00:06 DEBUG : Creating backend with remote "TestBox:" 2025/03/17 10:00:06 DEBUG : Config file has changed externally - reloading 2025/03/17 10:00:06 DEBUG : box root '': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListSubdir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 fstests.go:399: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObject === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir === RUN TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 === RUN TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurge === RUN TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot 2025/03/17 10:00:28 DEBUG : Creating backend with remote "TestBox:rclone-test-borejoq0woro/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/17 10:00:32 DEBUG : Creating backend with remote "TestBox:rclone-test-borejoq0woro/hello? sausage/êé" === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy === RUN TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata fstests.go:1289: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove === RUN TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata fstests.go:1398: Skipping test as can't write metadata === RUN TestIntegration/FsMkdir/FsPutFiles/FsDirMove 2025/03/17 10:01:04 DEBUG : Creating backend with remote "TestBox:rclone-test-tiwakez3yapa" 2025/03/17 10:01:05 DEBUG : box root 'rclone-test-tiwakez3yapa': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:01:06 DEBUG : box root 'rclone-test-tiwakez3yapa': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:01:11 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:01:14 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:01:20 DEBUG : box root 'rclone-test-tiwakez3yapa': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull === RUN TestIntegration/FsMkdir/FsPutFiles/FsPrecision === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectString === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectFs === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemote === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectHashes === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType fstests.go:1592: MimeType method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata fstests.go:1623: Metadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata fstests.go:1694: SetMetadata method not supported === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectSize === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpen === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectStorable === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile 2025/03/17 10:01:40 DEBUG : Creating backend with remote "TestBox:rclone-test-borejoq0woro/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/17 10:01:46 DEBUG : Creating backend with remote "TestBox:rclone-test-borejoq0woro/not found.txt" 2025/03/17 10:01:48 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestBox:" path "rclone-test-borejoq0woro" from "TestBox:rclone-test-borejoq0woro" 2025/03/17 10:01:48 DEBUG : Creating backend with remote "TestBox:" === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/List === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR fstests.go:1945: FS has no ListR interface === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove === RUN TestIntegration/FsMkdir/FsPutFiles/PublicLink 2025/03/17 10:01:58 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share single file 'file name.txt_does_not_exist' 2025/03/17 10:02:00 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share single file 'file name.txt' 2025/03/17 10:02:01 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share single file 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt' 2025/03/17 10:02:03 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share single file 'file name.txt' 2025/03/17 10:02:03 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠' 2025/03/17 10:02:04 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠' 2025/03/17 10:02:05 DEBUG : Creating backend with remote "TestBox:rclone-test-taceruh3vomu" 2025/03/17 10:02:05 DEBUG : box root 'rclone-test-taceruh3vomu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:02:06 DEBUG : box root 'rclone-test-taceruh3vomu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:02:07 DEBUG : box root 'rclone-test-taceruh3vomu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:02:09 DEBUG : box root 'rclone-test-borejoq0woro': attempting to share directory '' 2025/03/17 10:02:09 DEBUG : box root 'rclone-test-taceruh3vomu': Purge remote === RUN TestIntegration/FsMkdir/FsPutFiles/SetTier fstests.go:412: FS has no SetTier & GetTier interfaces === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap fstests.go:2109: Not a wrapping Fs === RUN TestIntegration/FsMkdir/FsPutFiles/Bucket fstests.go:2125: Not a bucket based backend === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectRemove === RUN TestIntegration/FsMkdir/FsPutFiles/ObjectAbout === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 === RUN TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 === RUN TestIntegration/FsMkdir/FsPutFiles/Internal fstests.go:2343: *box.Fs does not implement InternalTester === RUN TestIntegration/FsMkdir/FsPutChunked fstests.go:2364: *box.Fs does not implement SetUploadChunkSizer === RUN TestIntegration/FsMkdir/FsCopyChunked fstests.go:2485: *box.Fs does not implement SetCopyCutoff === RUN TestIntegration/FsMkdir/FsUploadUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize === RUN TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize === RUN TestIntegration/FsMkdir/FsRootCollapse 2025/03/17 10:02:28 DEBUG : Creating backend with remote "TestBox:rclone-test-borejoq0woro/deeper/nonexisting/directory" === RUN TestIntegration/FsMkdir/FsDirSetModTime fstests.go:2625: FS has no DirSetModTime interface === RUN TestIntegration/FsMkdir/FsMkdirMetadata fstests.go:2668: FS has no MkdirMetadata interface === RUN TestIntegration/FsMkdir/FsDirectory fstests.go:2725: FS has no Directory methods and doesn't Wrap 2025/03/17 10:02:32 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/17 10:02:32 ERROR : : error listing: directory not found 2025/03/17 10:02:32 DEBUG : box root 'rclone-test-borejoq0woro': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- PASS: TestIntegration (330.78s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.56s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.82s) --- PASS: TestIntegration/FsMkdir (327.00s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.20s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.33s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.34s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.33s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (115.63s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (6.07s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (6.13s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (5.38s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (5.49s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (5.71s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (6.73s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (7.05s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (6.27s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (6.04s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (6.16s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (6.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (5.62s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (5.58s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (5.58s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (5.99s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (6.52s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (6.66s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (6.09s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (6.06s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.69s) --- PASS: TestIntegration/FsMkdir/FsPutError (4.71s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (3.88s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- PASS: TestIntegration/FsMkdir/FsChangeNotify (35.32s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (146.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.87s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.87s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.50s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.54s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.75s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.77s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.84s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.63s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (2.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.03s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (8.10s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (8.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (10.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (5.12s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (16.43s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (16.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.64s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.60s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.61s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.64s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (1.86s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (1.36s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.31s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (3.46s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (1.24s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (3.35s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (5.70s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (9.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (2.76s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.36s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (6.83s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (2.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (12.21s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/SetTier (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectCheckWrap (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Bucket (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemove (3.55s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (6.17s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (3.09s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (3.08s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (7.55s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.50s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (5.05s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.13s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) PASS ok github.com/rclone/rclone/backend/box 330.793s "go test -v -timeout 1h0m0s -remote TestBox: -verbose" - Finished OK in 5m31.399427447s (try 1/5)