"./bisync.test -test.v -test.timeout 1h0m0s -remote 'TestGoogleCloudStorage,directory_markers:' -verbose" - Starting (try 1/5) 2025/04/24 03:26:46 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-vocenim1nuqu" 2025/04/24 03:26:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/24 03:26:46 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/04/24 03:26:46 DEBUG : Creating backend with remote "/tmp/rclone3113961604" === RUN TestBisyncRemoteLocal 2025/04/24 03:26:46 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-xuhitud4wiqa" 2025/04/24 03:26:46 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/04/24 03:26:46 NOTICE: remote: TestGoogleCloudStorage,directory_markers:rclone-test-xuhitud4wiqa === RUN TestBisyncRemoteLocal/all_changed 2025/04/24 03:26:46 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-xuhitud4wiqa/032646si" 2025/04/24 03:26:46 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/24 03:26:46 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/04/24 03:26:46 DEBUG : fs cache: renaming cache item "TestGoogleCloudStorage,directory_markers:rclone-test-xuhitud4wiqa/032646si" to be canonical "TestGoogleCloudStorage{juk_h}:rclone-test-xuhitud4wiqa/032646si" 2025/04/24 03:26:46 INFO : path1: Making directory 2025/04/24 03:26:48 DEBUG : path1/: Creating directory marker 2025/04/24 03:26:48 DEBUG : Creating backend with remote "TestGoogleCloudStorage,directory_markers:rclone-test-xuhitud4wiqa/032646si/all_changed/path1" 2025/04/24 03:26:48 DEBUG : TestGoogleCloudStorage: detected overridden config - adding "{juk_h}" suffix to name 2025/04/24 03:26:48 DEBUG : fs cache: renaming cache item "TestGoogleCloudStorage,directory_markers:rclone-test-xuhitud4wiqa/032646si/all_changed/path1" to be canonical "TestGoogleCloudStorage{juk_h}:rclone-test-xuhitud4wiqa/032646si/all_changed/path1" 2025/04/24 03:26:48 DEBUG : Creating backend with remote "/tmp/032646si" 2025/04/24 03:26:48 DEBUG : Creating backend with remote "/tmp/032646si/all_changed/path2" 2025/04/24 03:26:48 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial" 2025/04/24 03:26:48 DEBUG : Creating backend with remote "/tmp/032646si/initdir/test_all_changed-gitebok4" 2025/04/24 03:26:48 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : subdir: Making directory with metadata 2025/04/24 03:26:48 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/04/24 03:26:48 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/04/24 03:26:48 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt 2025/04/24 03:26:48 INFO : file1.copy1.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:48 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt 2025/04/24 03:26:48 INFO : file1.copy2.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : Local file system at /tmp/032646si/initdir/test_all_changed-gitebok4: Waiting for checks to finish 2025/04/24 03:26:48 DEBUG : Local file system at /tmp/032646si/initdir/test_all_changed-gitebok4: Waiting for transfers to finish 2025/04/24 03:26:48 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt 2025/04/24 03:26:48 INFO : file1.copy3.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt 2025/04/24 03:26:48 INFO : file1.copy4.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/04/24 03:26:48 INFO : file1.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt 2025/04/24 03:26:48 INFO : file1.copy5.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:48 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/04/24 03:26:48 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2025/04/24 03:26:48 INFO : subdir/file20.txt: Copied (new) 2025/04/24 03:26:48 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/04/24 03:26:48 INFO : RCLONE_TEST: Copied (new) 2025/04/24 03:26:48 INFO : subdir: Set directory modification time (using SetModTime) 2025/04/24 03:26:50 ERROR : : error listing: directory not found 2025/04/24 03:26:50 NOTICE: checking initFs Local file system at /tmp/032646si/initdir/test_all_changed-gitebok4 2025/04/24 03:26:50 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/04/24 03:26:50 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:50 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:50 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:50 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:50 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:50 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:50 INFO : subdir: Making directory 2025/04/24 03:26:51 DEBUG : subdir/: Creating directory marker 2025/04/24 03:26:51 DEBUG : /: Creating directory marker 2025/04/24 03:26:51 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/04/24 03:26:51 DEBUG : GCS bucket rclone-test-xuhitud4wiqa path 032646si/all_changed/path1: Waiting for checks to finish 2025/04/24 03:26:51 DEBUG : GCS bucket rclone-test-xuhitud4wiqa path 032646si/all_changed/path1: Waiting for transfers to finish 2025/04/24 03:26:51 DEBUG : /: Creating directory marker 2025/04/24 03:26:52 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/04/24 03:26:52 INFO : RCLONE_TEST: Copied (new) 2025/04/24 03:26:52 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:52 INFO : file1.copy2.txt: Copied (new) 2025/04/24 03:26:52 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:52 INFO : file1.copy3.txt: Copied (new) 2025/04/24 03:26:52 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:52 INFO : file1.copy1.txt: Copied (new) 2025/04/24 03:26:52 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:52 INFO : file1.copy4.txt: Copied (new) 2025/04/24 03:26:52 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:52 INFO : file1.copy5.txt: Copied (new) 2025/04/24 03:26:52 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:52 INFO : file1.txt: Copied (new) 2025/04/24 03:26:53 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/24 03:26:53 INFO : subdir/file20.txt: Copied (new) 2025/04/24 03:26:53 NOTICE: checking Path1 GCS bucket rclone-test-xuhitud4wiqa path 032646si/all_changed/path1 --- FAIL: TestBisyncRemoteLocal (7.14s) --- FAIL: TestBisyncRemoteLocal/all_changed (7.14s) panic: runtime error: slice bounds out of range [27:26] [recovered] panic: runtime error: slice bounds out of range [27:26] goroutine 52 [running]: testing.tRunner.func1.2({0x24b2740, 0xc000908978}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1632 +0x230 testing.tRunner.func1() /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1635 +0x35e panic({0x24b2740?, 0xc000908978?}) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/runtime/panic.go:785 +0x132 github.com/rclone/rclone/backend/googlecloudstorage.(*Fs).list(0xc000620140, {0x2abd960, 0x3e661a0}, {0xc000b40149, 0x18}, {0xc000b40162, 0x1a}, {0xc000b40162, 0x1a}, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/googlecloudstorage/googlecloudstorage.go:717 +0xffe github.com/rclone/rclone/backend/googlecloudstorage.(*Fs).ListR.func1({0xc000b40149?, 0x0?}, {0xc000b40162?, 0x47233d?}, {0xc000b40162?, 0x7f1ed30c9108?}, 0xa0?) /home/rclone/go/src/github.com/rclone/rclone/backend/googlecloudstorage/googlecloudstorage.go:850 +0x95 github.com/rclone/rclone/backend/googlecloudstorage.(*Fs).ListR(0xc000620140, {0x2abd960, 0x3e661a0}, {0x0?, 0x2580760?}, 0xc00069c730) /home/rclone/go/src/github.com/rclone/rclone/backend/googlecloudstorage/googlecloudstorage.go:877 +0x12a github.com/rclone/rclone/fs/walk.listR({0x2abd960, 0x3e661a0}, {0x2ad35d0, 0xc000620140}, {0x0, 0x0}, 0x1, 0x3, 0xc00078a5b8, 0xc000aa0408, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:299 +0x2a3 github.com/rclone/rclone/fs/walk.ListR({0x2abd960, 0x3e661a0}, {0x2ad35d0, 0xc000620140}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc00078a5b8) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:163 +0x1d5 github.com/rclone/rclone/fs/walk.GetAll({0x2abd960, 0x3e661a0}, {0x2ad35d0, 0xc000620140}, {0x0, 0x0}, 0x1, 0xffffffffffffffff) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:634 +0x105 github.com/rclone/rclone/fstest.CheckListingWithRoot(0xc0006d0000, {0x2ad35d0, 0xc000620140}, {0x0, 0x0}, {0xc0008c7180, 0x8, 0x8}, {0xc000a9f370, 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(0xc000504380, {0x2abd960, 0x3e661a0}, 0x605?, {0xc0005bc0a5?, 0x5599c0?}) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460 +0xffb github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0xc0006d0000) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358 +0x234 testing.tRunner(0xc0006d0000, 0xc0006c8840) /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1690 +0xf4 created by testing.(*T).Run in goroutine 22 /home/rclone/go/pkg/mod/golang.org/toolchain@v0.0.1-go1.23.0.linux-amd64/src/testing/testing.go:1743 +0x390 "./bisync.test -test.v -test.timeout 1h0m0s -remote 'TestGoogleCloudStorage,directory_markers:' -verbose" - Finished ERROR in 7.207273469s (try 1/5): exit status 2: Failed [TestBisyncRemoteLocal/all_changed]