"go test -v -timeout 1h0m0s -remote TestBox: -verbose" - Starting (try 1/5) === RUN TestIntegration fstests.go:438: Using remote "TestBox:" 2025/03/07 09:12:01 DEBUG : Creating backend with remote "TestBox:rclone-test-sagazax7xide" 2025/03/07 09:12:01 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/03/07 09:12:01 DEBUG : box root 'rclone-test-sagazax7xide': Token expired but no uploads in progress - doing nothing 2025/03/07 09:12:01 DEBUG : TestBox: Loaded invalid token from config file - ignoring 2025/03/07 09:12:01 DEBUG : Saving config "token" in section "TestBox" of the config file 2025/03/07 09:12:01 DEBUG : TestBox: Saved new token in config file 2025/03/07 09:12:02 DEBUG : box root 'rclone-test-sagazax7xide': 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/07 09:12:03 DEBUG : box root 'rclone-test-sagazax7xide': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:12:04 DEBUG : box root 'rclone-test-sagazax7xide': 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/07 09:12:06 DEBUG : box root 'rclone-test-sagazax7xide': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsMkdir/FsMkdirRmdirSubdir 2025/03/07 09:12:07 INFO : dir/subdir: Making directory 2025/03/07 09:12:11 INFO : dir/subdir: Removing directory 2025/03/07 09:12: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/07 09:12:15 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/07 09:14:25 INFO : dir: Making directory 2025/03/07 09:14:26 INFO : dir/subdir1: Making directory 2025/03/07 09:14:27 INFO : dir/subdir3: Making directory 2025/03/07 09:14:27 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823613051") 2025/03/07 09:14:28 INFO : dir/subdir2: Making directory 2025/03/07 09:14:28 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823614281") 2025/03/07 09:14:29 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823615274") 2025/03/07 09:14:30 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823616273") 2025/03/07 09:14:31 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823617282") 2025/03/07 09:14:32 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823618278") 2025/03/07 09:14:33 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823619275") 2025/03/07 09:14:34 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823620274") 2025/03/07 09:14:35 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823621280") fstests.go:931: Try 1/10 waiting for dirChanges and objChanges 2025/03/07 09:14:36 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823622282") 2025/03/07 09:14:37 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823623278") 2025/03/07 09:14:38 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823624276") fstests.go:931: Try 2/10 waiting for dirChanges and objChanges 2025/03/07 09:14:39 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823625273") 2025/03/07 09:14:40 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823626281") 2025/03/07 09:14:41 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823627282") fstests.go:931: Try 3/10 waiting for dirChanges and objChanges 2025/03/07 09:14:42 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823628280") 2025/03/07 09:14:43 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823629285") 2025/03/07 09:14:44 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823630284") fstests.go:931: Try 4/10 waiting for dirChanges and objChanges 2025/03/07 09:14:44 DEBUG : box root 'rclone-test-sagazax7xide': ["invalid utf-8‛FE"(1)|folder|ITEM_TRASH|310580587188|f6387a32287bed99e4a2f66d0ae8eb1ff6b56cc3] added old path ("invalid utf-8\xfe") for notify 2025/03/07 09:14:44 DEBUG : doChangeNotify("invalid utf-8\xfe", 0) 2025/03/07 09:14:44 DEBUG : box root 'rclone-test-sagazax7xide': Received 1 events, resulting in 1 paths and 1 notifications 2025/03/07 09:14:44 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823631300") 2025/03/07 09:14:45 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823631541") 2025/03/07 09:14:46 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823632307") 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823633295") fstests.go:931: Try 5/10 waiting for dirChanges and objChanges 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': ["invalid utf-8‛FE"(1)|folder|ITEM_TRASH|310580587188|f6387a32287bed99e4a2f66d0ae8eb1ff6b56cc3] ignored due to duplicate EventID 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': ["test%46.txt"(1)|folder|ITEM_TRASH|310583147854|8a9f2e637cde22690951289d571c11001fcf4d87] added old path ("test%46.txt") for notify 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': ["Hello, 世界"(0)|folder|ITEM_CREATE|310580219278|89b9134bfcce122503f5128592038827619f967e] added new path ("hello? sausage/êé/Hello, 世界") for notify 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': ["invalid utf-8‛FE"(1)|file|ITEM_TRASH|1796565594082|eb5a42e15241718f29948dc0d4e9d11f2fd22adb] old parent not cached 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': ["file3"(0)|file|ITEM_UPLOAD|1796559889473|4c07258cc9d6ec2ed01a66c80e83ce8a6a2b245f] added new path ("dir/file3") for notify 2025/03/07 09:14:47 DEBUG : doChangeNotify("test%46.txt", 0) 2025/03/07 09:14:47 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界", 0) 2025/03/07 09:14:47 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界", 0 2025/03/07 09:14:47 DEBUG : doChangeNotify("dir/file3", 1) 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': Received 5 events, resulting in 3 paths and 3 notifications 2025/03/07 09:14:47 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823634311") 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823634592") 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["test%46.txt"(1)|folder|ITEM_TRASH|310583147854|8a9f2e637cde22690951289d571c11001fcf4d87] ignored due to duplicate EventID 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["Hello, 世界"(0)|folder|ITEM_CREATE|310580219278|89b9134bfcce122503f5128592038827619f967e] ignored due to duplicate EventID 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["invalid utf-8‛FE"(1)|file|ITEM_TRASH|1796565594082|eb5a42e15241718f29948dc0d4e9d11f2fd22adb] ignored due to duplicate EventID 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["file3"(0)|file|ITEM_UPLOAD|1796559889473|4c07258cc9d6ec2ed01a66c80e83ce8a6a2b245f] ignored due to duplicate EventID 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["zero-length-file"(0)|file|ITEM_UPLOAD|1796559515477|060ddae76d54035ff91e48a064af1e4640e38a0f] added new path ("zero-length-file") for notify 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["file2"(0)|file|ITEM_UPLOAD|1796561905386|d704d64d056598ca4cef439b3c30edfd56ced65d] added new path ("dir/file2") for notify 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["test%46.txt"(1)|file|ITEM_TRASH|1796562404802|e7c7bcb8a82f65d6301b62113a74a6b52dad02d3] old parent not cached 2025/03/07 09:14:48 DEBUG : doChangeNotify("zero-length-file", 1) 2025/03/07 09:14:48 DEBUG : doChangeNotify("dir/file2", 1) 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': Received 7 events, resulting in 2 paths and 2 notifications 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823635287") 2025/03/07 09:14:48 DEBUG : box root 'rclone-test-sagazax7xide': ["test%46.txt"(1)|folder|ITEM_TRASH|310583147854|8a9f2e637cde22690951289d571c11001fcf4d87] ignored due to duplicate EventID 2025/03/07 09:14:49 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823635567") 2025/03/07 09:14:50 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823636308") fstests.go:931: Try 6/10 waiting for dirChanges and objChanges 2025/03/07 09:14:50 DEBUG : box root 'rclone-test-sagazax7xide': ["Hello, 世界"(0)|folder|ITEM_CREATE|310580219278|89b9134bfcce122503f5128592038827619f967e] ignored due to duplicate EventID 2025/03/07 09:14:50 DEBUG : box root 'rclone-test-sagazax7xide': ["invalid utf-8‛FE"(1)|file|ITEM_TRASH|1796565594082|eb5a42e15241718f29948dc0d4e9d11f2fd22adb] ignored due to duplicate EventID 2025/03/07 09:14:51 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823637298") 2025/03/07 09:14:51 DEBUG : box root 'rclone-test-sagazax7xide': ["file3"(0)|file|ITEM_UPLOAD|1796559889473|4c07258cc9d6ec2ed01a66c80e83ce8a6a2b245f] ignored due to duplicate EventID 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823638292") 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["zero-length-file"(0)|file|ITEM_UPLOAD|1796559515477|060ddae76d54035ff91e48a064af1e4640e38a0f] ignored due to duplicate EventID 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["file2"(0)|file|ITEM_UPLOAD|1796561905386|d704d64d056598ca4cef439b3c30edfd56ced65d] ignored due to duplicate EventID 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["test%46.txt"(1)|file|ITEM_TRASH|1796562404802|e7c7bcb8a82f65d6301b62113a74a6b52dad02d3] ignored due to duplicate EventID 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["subdir1"(0)|folder|ITEM_CREATE|310580836590|49b46df3221faa928de0000b1e4ec28ad2959750] added new path ("dir/subdir1") for notify 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["hello? sausage"(0)|folder|ITEM_CREATE|310583577535|87d20c9ca9010384acd012f2f5b34ecff74c46f6] added new path ("hello? sausage") for notify 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["êé"(0)|folder|ITEM_CREATE|310580927276|0692b3951aacb57ba3ed7eb90f8a60ef06f0b427] added new path ("hello? sausage/êé") for notify 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': ["subdir2"(0)|folder|ITEM_CREATE|310580082573|d510817cec5d2b43aaf26035f57238274242bb5c] added new path ("dir/subdir2") for notify 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': [" \" ' @ < > & ? + ≠"(0)|folder|ITEM_CREATE|310581958993|5054cd6a36dd2f6e1fb467d0f2e36b6d1c5d1421] added new path ("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠") for notify 2025/03/07 09:14:52 DEBUG : doChangeNotify("dir/subdir1", 0) 2025/03/07 09:14:52 DEBUG : doChangeNotify("hello? sausage", 0) 2025/03/07 09:14:52 DEBUG : Ignoring notify for file1 or file2: "hello? sausage", 0 2025/03/07 09:14:52 DEBUG : doChangeNotify("hello? sausage/êé", 0) 2025/03/07 09:14:52 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé", 0 2025/03/07 09:14:52 DEBUG : doChangeNotify("dir/subdir2", 0) 2025/03/07 09:14:52 DEBUG : doChangeNotify("hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠", 0) 2025/03/07 09:14:52 DEBUG : Ignoring notify for file1 or file2: "hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠", 0 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': Received 8 events, resulting in 5 paths and 5 notifications 2025/03/07 09:14:52 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823639300") 2025/03/07 09:14:53 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823639606") fstests.go:931: Try 7/10 waiting for dirChanges and objChanges 2025/03/07 09:14:53 DEBUG : box root 'rclone-test-sagazax7xide': ["subdir1"(0)|folder|ITEM_CREATE|310580836590|49b46df3221faa928de0000b1e4ec28ad2959750] ignored due to duplicate EventID 2025/03/07 09:14:54 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823640298") 2025/03/07 09:14:55 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823641288") 2025/03/07 09:14:55 DEBUG : box root 'rclone-test-sagazax7xide': ["hello? sausage"(0)|folder|ITEM_CREATE|310583577535|87d20c9ca9010384acd012f2f5b34ecff74c46f6] ignored due to duplicate EventID 2025/03/07 09:14:55 DEBUG : box root 'rclone-test-sagazax7xide': ["êé"(0)|folder|ITEM_CREATE|310580927276|0692b3951aacb57ba3ed7eb90f8a60ef06f0b427] ignored due to duplicate EventID 2025/03/07 09:14:56 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823642296") fstests.go:931: Try 8/10 waiting for dirChanges and objChanges 2025/03/07 09:14:56 DEBUG : box root 'rclone-test-sagazax7xide': ["subdir2"(0)|folder|ITEM_CREATE|310580082573|d510817cec5d2b43aaf26035f57238274242bb5c] ignored due to duplicate EventID 2025/03/07 09:14:56 DEBUG : box root 'rclone-test-sagazax7xide': [" \" ' @ < > & ? + ≠"(0)|folder|ITEM_CREATE|310581958993|5054cd6a36dd2f6e1fb467d0f2e36b6d1c5d1421] ignored due to duplicate EventID 2025/03/07 09:14:57 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823643289") 2025/03/07 09:14:57 DEBUG : box root 'rclone-test-sagazax7xide': ["subdir3"(0)|folder|ITEM_CREATE|310580272324|66d6d6b00973cd74afb75dd260367e6d8641ed69] added new path ("dir/subdir3") for notify 2025/03/07 09:14:57 DEBUG : doChangeNotify("dir/subdir3", 0) 2025/03/07 09:14:57 DEBUG : box root 'rclone-test-sagazax7xide': Received 2 events, resulting in 1 paths and 1 notifications 2025/03/07 09:14:57 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823644293") 2025/03/07 09:14:58 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823644575") 2025/03/07 09:14:59 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823645292") fstests.go:931: Try 9/10 waiting for dirChanges and objChanges 2025/03/07 09:15:00 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823646286") 2025/03/07 09:15:01 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823647294") 2025/03/07 09:15:01 DEBUG : box root 'rclone-test-sagazax7xide': ["zero-length-file"(1)|file|ITEM_TRASH|1796559515477|b3572741a66fcc838f2489537f582bccbf1fa0cd] ignored due to duplicate EventID 2025/03/07 09:15:01 DEBUG : box root 'rclone-test-sagazax7xide': ["subdir3"(0)|folder|ITEM_CREATE|310580272324|66d6d6b00973cd74afb75dd260367e6d8641ed69] ignored due to duplicate EventID 2025/03/07 09:15:02 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823648283") fstests.go:935: map[dir/subdir1:{} dir/subdir2:{} dir/subdir3:{} invalid utf-8:{} test%46.txt:{}] does not contain [dir/subdir1 dir/subdir3 dir/subdir2] or map[dir/file2:{} dir/file3:{} zero-length-file:{}] does not contain [dir/file2 dir/file4 dir/file3] 2025/03/07 09:15:02 DEBUG : box root 'rclone-test-sagazax7xide': ["dir"(0)|folder|ITEM_CREATE|310581187141|01ff127d2c39aa48e4c547c47a73cd72136f7e72] added new path ("dir") for notify 2025/03/07 09:15:02 DEBUG : doChangeNotify("dir", 0) 2025/03/07 09:15:02 DEBUG : box root 'rclone-test-sagazax7xide': Received 1 events, resulting in 1 paths and 1 notifications 2025/03/07 09:15:02 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823649283") 2025/03/07 09:15:03 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823649537") 2025/03/07 09:15:03 DEBUG : box root 'rclone-test-sagazax7xide': ["dir"(0)|folder|ITEM_CREATE|310581187141|01ff127d2c39aa48e4c547c47a73cd72136f7e72] ignored due to duplicate EventID 2025/03/07 09:15:04 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823650295") 2025/03/07 09:15:05 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823651289") 2025/03/07 09:15:06 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823652292") 2025/03/07 09:15:07 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823653292") 2025/03/07 09:15:07 DEBUG : box root 'rclone-test-sagazax7xide': ["file4"(0)|file|ITEM_UPLOAD|1796552951231|1642004559a0c59fc2e181c9a5cd1f884596bfca] added new path ("dir/file4") for notify 2025/03/07 09:15:07 DEBUG : doChangeNotify("dir/file4", 1) 2025/03/07 09:15:07 DEBUG : box root 'rclone-test-sagazax7xide': Received 1 events, resulting in 1 paths and 1 notifications 2025/03/07 09:15:07 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823654286") 2025/03/07 09:15:08 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823654537") 2025/03/07 09:15:09 DEBUG : box root 'rclone-test-sagazax7xide': Checking for changes on remote (next_stream_position: "30401038823655283") === RUN TestIntegration/FsMkdir/FsPutFiles === 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/07 09:15:21 DEBUG : Creating backend with remote "TestBox:" 2025/03/07 09:15:22 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/07 09:15:43 DEBUG : Creating backend with remote "TestBox:rclone-test-sagazax7xide/dirToPurgeFromRoot" === RUN TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir 2025/03/07 09:15:48 DEBUG : Creating backend with remote "TestBox:rclone-test-sagazax7xide/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/07 09:16:24 DEBUG : Creating backend with remote "TestBox:rclone-test-dojotuw3yalu" 2025/03/07 09:16:24 DEBUG : box root 'rclone-test-dojotuw3yalu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:16:25 DEBUG : box root 'rclone-test-dojotuw3yalu': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:16:30 DEBUG : box root 'rclone-test-sagazax7xide': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:16:33 DEBUG : box root 'rclone-test-sagazax7xide': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:16:38 DEBUG : box root 'rclone-test-dojotuw3yalu': 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/07 09:17:02 DEBUG : Creating backend with remote "TestBox:rclone-test-sagazax7xide/hello? sausage/êé/Hello, 世界/ \" ' @ < > & ? + ≠/z.txt" === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot === RUN TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound 2025/03/07 09:17:09 DEBUG : Creating backend with remote "TestBox:rclone-test-sagazax7xide/not found.txt" 2025/03/07 09:17:12 ERROR : : error listing: directory not found === RUN TestIntegration/FsMkdir/FsPutFiles/FromRoot fstests.go:1911: Opening root remote "TestBox:" path "rclone-test-sagazax7xide" from "TestBox:rclone-test-sagazax7xide" 2025/03/07 09:17:12 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/07 09:17:23 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share single file 'file name.txt_does_not_exist' 2025/03/07 09:17:23 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share single file 'file name.txt' 2025/03/07 09:17:25 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share single file 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠/z.txt' 2025/03/07 09:17:26 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share single file 'file name.txt' 2025/03/07 09:17:27 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠' 2025/03/07 09:17:27 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share directory 'hello? sausage/êé/Hello, 世界/ " ' @ < > & ? + ≠' 2025/03/07 09:17:28 DEBUG : Creating backend with remote "TestBox:rclone-test-gecagex2fiba" 2025/03/07 09:17:28 DEBUG : box root 'rclone-test-gecagex2fiba': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:17:29 DEBUG : box root 'rclone-test-gecagex2fiba': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:17:30 DEBUG : box root 'rclone-test-gecagex2fiba': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:17:31 DEBUG : box root 'rclone-test-sagazax7xide': attempting to share directory '' 2025/03/07 09:17:32 DEBUG : box root 'rclone-test-gecagex2fiba': 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/07 09:17:51 DEBUG : Creating backend with remote "TestBox:rclone-test-sagazax7xide/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/07 09:17:57 DEBUG : box root 'rclone-test-sagazax7xide': Ignoring "Shared folder — ForNick" - unknown type "web_link" 2025/03/07 09:17:57 ERROR : : error listing: directory not found 2025/03/07 09:17:57 DEBUG : box root 'rclone-test-sagazax7xide': Ignoring "Shared folder — ForNick" - unknown type "web_link" === RUN TestIntegration/FsShutdown --- FAIL: TestIntegration (356.62s) --- SKIP: TestIntegration/FsCheckWrap (0.00s) --- SKIP: TestIntegration/FsCommand (0.00s) --- PASS: TestIntegration/FsRmdirNotFound (0.60s) --- PASS: TestIntegration/FsString (0.00s) --- PASS: TestIntegration/FsName (0.00s) --- PASS: TestIntegration/FsRoot (0.00s) --- PASS: TestIntegration/FsRmdirEmpty (0.92s) --- FAIL: TestIntegration/FsMkdir (351.67s) --- PASS: TestIntegration/FsMkdir/FsMkdirRmdirSubdir (6.34s) --- PASS: TestIntegration/FsMkdir/FsListEmpty (0.38s) --- PASS: TestIntegration/FsMkdir/FsListDirEmpty (0.36s) --- SKIP: TestIntegration/FsMkdir/FsListRDirEmpty (0.00s) --- PASS: TestIntegration/FsMkdir/FsListDirNotFound (0.35s) --- SKIP: TestIntegration/FsMkdir/FsListRDirNotFound (0.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding (120.32s) --- PASS: TestIntegration/FsMkdir/FsEncoding/control_chars (6.10s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot (5.76s) --- PASS: TestIntegration/FsMkdir/FsEncoding/dot_dot (5.61s) --- PASS: TestIntegration/FsMkdir/FsEncoding/punctuation (5.74s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_space (6.45s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_tilde (7.51s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_CR (7.00s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_LF (6.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_HT (6.71s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_VT (6.15s) --- PASS: TestIntegration/FsMkdir/FsEncoding/leading_dot (5.90s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_space (5.65s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_CR (5.29s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_LF (5.52s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_HT (7.39s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_VT (6.95s) --- PASS: TestIntegration/FsMkdir/FsEncoding/trailing_dot (6.56s) --- PASS: TestIntegration/FsMkdir/FsEncoding/invalid_UTF-8 (6.67s) --- PASS: TestIntegration/FsMkdir/FsEncoding/URL_encoding (6.33s) --- PASS: TestIntegration/FsMkdir/FsNewObjectNotFound (0.72s) --- PASS: TestIntegration/FsMkdir/FsPutError (5.08s) --- PASS: TestIntegration/FsMkdir/FsPutZeroLength (3.78s) --- SKIP: TestIntegration/FsMkdir/FsOpenWriterAt (0.00s) --- SKIP: TestIntegration/FsMkdir/FsOpenChunkWriter (0.00s) --- FAIL: TestIntegration/FsMkdir/FsChangeNotify (44.34s) --- PASS: TestIntegration/FsMkdir/FsPutFiles (153.13s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirFile2 (1.92s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirFile2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListR (1.85s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir (1.57s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListDirRoot (0.59s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRDirRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListSubdir (0.69s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRSubdir#01 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListLevel2 (0.72s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsListRLevel2 (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1 (1.80s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObject (0.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive (2.81s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectCaseInsensitive/Dir (2.22s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListFile1and2 (1.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsNewObjectDir (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurge (7.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPurgeRoot (10.21s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsListRootedSubdir (14.01s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsCopy (5.51s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsCopy/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsMove (16.23s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FsMove/Metadata (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsDirMove (15.48s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsRmdirFull (0.30s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPrecision (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectString (0.60s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectFs (0.65s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectRemote (0.61s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectHashes (0.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectModTime (0.66s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMimeType (0.71s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectMetadata (0.70s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/ObjectSetMetadata (0.74s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSetModTime (2.62s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectSize (0.71s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpen (2.16s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenSeek (1.53s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectOpenRange (4.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectPartialRead (1.45s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectUpdate (4.12s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectStorable (0.77s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile (6.95s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFile/FsRoot (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsIsFileNotFound (2.44s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot (10.52s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/List (3.14s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListEntries (0.44s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/FromRoot/ListR (0.00s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put (6.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FromRoot/Put/Remove (2.75s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/PublicLink (10.31s) --- 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.51s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/ObjectAbout (0.29s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream (5.72s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/0 (2.94s) --- PASS: TestIntegration/FsMkdir/FsPutFiles/FsPutStream/100 (2.78s) --- SKIP: TestIntegration/FsMkdir/FsPutFiles/Internal (0.00s) --- SKIP: TestIntegration/FsMkdir/FsPutChunked (0.00s) --- SKIP: TestIntegration/FsMkdir/FsCopyChunked (0.00s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize (9.24s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsPutUnknownSize (2.52s) --- PASS: TestIntegration/FsMkdir/FsUploadUnknownSize/FsUpdateUnknownSize (6.72s) --- PASS: TestIntegration/FsMkdir/FsRootCollapse (2.81s) --- SKIP: TestIntegration/FsMkdir/FsDirSetModTime (0.00s) --- SKIP: TestIntegration/FsMkdir/FsMkdirMetadata (0.00s) --- SKIP: TestIntegration/FsMkdir/FsDirectory (0.00s) --- PASS: TestIntegration/FsShutdown (0.00s) FAIL exit status 1 FAIL github.com/rclone/rclone/backend/box 356.630s "go test -v -timeout 1h0m0s -remote TestBox: -verbose" - Finished ERROR in 5m57.177364005s (try 1/5): exit status 1: Failed [TestIntegration/FsMkdir/FsChangeNotify]