"./bisync.test -test.v -test.timeout 1h0m0s -remote 'TestGoogleCloudStorage,directory_markers:' -verbose" - Starting (try 1/5) 2025/01/26 04:48:08 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-nivazij5vuda" 2025/01/26 04:48:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/26 04:48:08 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/01/26 04:48:08 DEBUG : Creating backend with remote "/tmp/rclone4181610558" === RUN TestBisyncRemoteLocal 2025/01/26 04:48:08 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-susegib5bujo" 2025/01/26 04:48:08 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/01/26 04:48:08 NOTICE: remote: TestGoogleCloudStorage,directory_markers:rclone-test-susegib5bujo === RUN TestBisyncRemoteLocal/all_changed 2025/01/26 04:48:08 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-susegib5bujo/044808ze" 2025/01/26 04:48:08 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/01/26 04:48:08 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/01/26 04:48:09 DEBUG : fs cache: renaming cache item "TestGoogleCloudStorage,directory_markers:rclone-test-susegib5bujo/044808ze" to be canonical "TestGoogleCloudStorage{juk_h}:rclone-test-susegib5bujo/044808ze" 2025/01/26 04:48:09 INFO : path1: Making directory 2025/01/26 04:48:11 DEBUG : path1/: Creating directory marker 2025/01/26 04:48:11 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-susegib5bujo/044808ze/all_changed/path1" 2025/01/26 04:48:11 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/01/26 04:48:11 DEBUG : fs cache: renaming cache item "TestGoogleCloudStorage,directory_markers:rclone-test-susegib5bujo/044808ze/all_changed/path1" to be canonical "TestGoogleCloudStorage{juk_h}:rclone-test-susegib5bujo/044808ze/all_changed/path1" 2025/01/26 04:48:11 DEBUG : Creating backend with remote "/tmp/044808ze" 2025/01/26 04:48:11 DEBUG : Creating backend with remote "/tmp/044808ze/all_changed/path2" 2025/01/26 04:48:11 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial" 2025/01/26 04:48:11 DEBUG : Creating backend with remote "/tmp/044808ze/initdir/test_all_changed-pewihoc5" 2025/01/26 04:48:11 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : subdir: Making directory with metadata 2025/01/26 04:48:11 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/01/26 04:48:11 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/01/26 04:48:11 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:11 DEBUG : Local file system at /tmp/044808ze/initdir/test_all_changed-pewihoc5: Waiting for checks to finish 2025/01/26 04:48:11 DEBUG : Local file system at /tmp/044808ze/initdir/test_all_changed-pewihoc5: Waiting for transfers to finish 2025/01/26 04:48:11 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt 2025/01/26 04:48:11 INFO : file1.copy3.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt 2025/01/26 04:48:11 INFO : file1.copy2.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt 2025/01/26 04:48:11 INFO : file1.copy1.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt 2025/01/26 04:48:11 INFO : file1.copy4.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt 2025/01/26 04:48:11 INFO : file1.copy5.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/01/26 04:48:11 INFO : file1.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:11 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2025/01/26 04:48:11 INFO : subdir/file20.txt: Copied (new) 2025/01/26 04:48:11 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/01/26 04:48:11 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/01/26 04:48:11 INFO : RCLONE_TEST: Copied (new) 2025/01/26 04:48:11 INFO : subdir: Set directory modification time (using SetModTime) 2025/01/26 04:48:13 ERROR : : error listing: directory not found 2025/01/26 04:48:13 NOTICE: checking initFs Local file system at /tmp/044808ze/initdir/test_all_changed-pewihoc5 2025/01/26 04:48:13 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/01/26 04:48:13 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:13 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:13 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:13 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:13 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:13 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:13 INFO : subdir: Making directory 2025/01/26 04:48:14 DEBUG : subdir/: Creating directory marker 2025/01/26 04:48:14 DEBUG : /: Creating directory marker 2025/01/26 04:48:14 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/01/26 04:48:14 DEBUG : GCS bucket rclone-test-susegib5bujo path 044808ze/all_changed/path1: Waiting for checks to finish 2025/01/26 04:48:14 DEBUG : GCS bucket rclone-test-susegib5bujo path 044808ze/all_changed/path1: Waiting for transfers to finish 2025/01/26 04:48:14 DEBUG : /: Creating directory marker 2025/01/26 04:48:15 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:15 INFO : file1.copy3.txt: Copied (new) 2025/01/26 04:48:15 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/01/26 04:48:15 INFO : RCLONE_TEST: Copied (new) 2025/01/26 04:48:15 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:15 INFO : file1.copy2.txt: Copied (new) 2025/01/26 04:48:15 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:15 INFO : file1.copy4.txt: Copied (new) 2025/01/26 04:48:15 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:15 INFO : file1.copy1.txt: Copied (new) 2025/01/26 04:48:16 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:16 INFO : file1.copy5.txt: Copied (new) 2025/01/26 04:48:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:16 INFO : file1.txt: Copied (new) 2025/01/26 04:48:16 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/01/26 04:48:16 INFO : subdir/file20.txt: Copied (new) 2025/01/26 04:48:16 NOTICE: checking Path1 GCS bucket rclone-test-susegib5bujo path 044808ze/all_changed/path1 --- FAIL: TestBisyncRemoteLocal (7.51s) --- FAIL: TestBisyncRemoteLocal/all_changed (7.51s) panic: runtime error: slice bounds out of range [27:26] [recovered] panic: runtime error: slice bounds out of range [27:26] goroutine 7 [running]: testing.tRunner.func1.2({0x2354960, 0xc0005569d8}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1631 +0x24a testing.tRunner.func1() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1634 +0x377 panic({0x2354960?, 0xc0005569d8?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/runtime/panic.go:770 +0x132 github.com/rclone/rclone/backend/googlecloudstorage.(*Fs).list(0xc000458140, {0x292e280, 0x3c16600}, {0xc00005e749, 0x18}, {0xc00005e762, 0x1a}, {0xc00005e762, 0x1a}, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/googlecloudstorage/googlecloudstorage.go:717 +0xfec github.com/rclone/rclone/backend/googlecloudstorage.(*Fs).ListR.func1({0xc00005e749?, 0x0?}, {0xc00005e762?, 0xc000384540?}, {0xc00005e762?, 0xc0003d95a8?}, 0xdb?) /home/rclone/go/src/github.com/rclone/rclone/backend/googlecloudstorage/googlecloudstorage.go:850 +0xa7 github.com/rclone/rclone/backend/googlecloudstorage.(*Fs).ListR(0xc000458140, {0x292e280, 0x3c16600}, {0x0?, 0x241dc20?}, 0xc0004200f0) /home/rclone/go/src/github.com/rclone/rclone/backend/googlecloudstorage/googlecloudstorage.go:877 +0x14a github.com/rclone/rclone/fs/walk.listR({0x292e280, 0x3c16600}, {0x2942c08, 0xc000458140}, {0x0, 0x0}, 0x1, 0x3, 0xc0008c41c8, 0xc000920450, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:298 +0x2a3 github.com/rclone/rclone/fs/walk.ListR({0x292e280, 0x3c16600}, {0x2942c08, 0xc000458140}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc0008c41c8) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:162 +0x1d5 github.com/rclone/rclone/fs/walk.GetAll({0x292e280, 0x3c16600}, {0x2942c08, 0xc000458140}, {0x0, 0x0}, 0x1, 0xffffffffffffffff) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:631 +0x105 github.com/rclone/rclone/fstest.CheckListingWithRoot(0xc000164000, {0x2942c08, 0xc000458140}, {0x0, 0x0}, {0xc0005d8540, 0x8, 0x8}, {0xc000922f10, 0x1, ...}, ...) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:274 +0x3d6 github.com/rclone/rclone/fstest.CheckListingWithPrecision(...) /home/rclone/go/src/github.com/rclone/rclone/fstest/fstest.go:332 github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase(0xc000384700, {0x292e280, 0x3c16600}, 0x604?, {0xc000015685?, 0x54d680?}) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:458 +0x101c github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0xc000164000) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:356 +0x234 testing.tRunner(0xc000164000, 0xc0002db1a0) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1689 +0xfb created by testing.(*T).Run in goroutine 31 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.22.0.linux-amd64/src/testing/testing.go:1742 +0x390 "./bisync.test -test.v -test.timeout 1h0m0s -remote 'TestGoogleCloudStorage,directory_markers:' -verbose" - Finished ERROR in 7.551093014s (try 1/5): exit status 2: Failed [TestBisyncRemoteLocal/all_changed]