"./bisync.test -test.v -test.timeout 1h0m0s -remote 'TestAzureBlob,directory_markers:' -verbose" - Starting (try 1/5) 2025/02/20 05:51:16 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-genomey2juvu" 2025/02/20 05:51:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/20 05:51:16 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/02/20 05:51:16 DEBUG : Azure container rclone-test-genomey2juvu: Using directory markers 2025/02/20 05:51:16 DEBUG : Creating backend with remote "/tmp/rclone1677953933" === RUN TestBisyncRemoteLocal 2025/02/20 05:51:16 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-daseten1pilu" 2025/02/20 05:51:16 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/02/20 05:51:16 DEBUG : Azure container rclone-test-daseten1pilu: Using directory markers 2025/02/20 05:51:16 NOTICE: remote: TestAzureBlob,directory_markers:rclone-test-daseten1pilu === RUN TestBisyncRemoteLocal/all_changed 2025/02/20 05:51:16 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-daseten1pilu/055116nu" 2025/02/20 05:51:16 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/02/20 05:51:16 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/02/20 05:51:16 DEBUG : Azure container rclone-test-daseten1pilu path 055116nu: Using directory markers 2025/02/20 05:51:16 DEBUG : fs cache: renaming cache item "TestAzureBlob,directory_markers:rclone-test-daseten1pilu/055116nu" to be canonical "TestAzureBlob{juk_h}:rclone-test-daseten1pilu/055116nu" 2025/02/20 05:51:16 INFO : path1: Making directory 2025/02/20 05:51:16 DEBUG : path1/: Creating directory marker 2025/02/20 05:51:16 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-daseten1pilu/055116nu/all_changed/path1" 2025/02/20 05:51:16 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/02/20 05:51:16 DEBUG : Azure container rclone-test-daseten1pilu path 055116nu/all_changed/path1: Using directory markers 2025/02/20 05:51:16 DEBUG : fs cache: renaming cache item "TestAzureBlob,directory_markers:rclone-test-daseten1pilu/055116nu/all_changed/path1" to be canonical "TestAzureBlob{juk_h}:rclone-test-daseten1pilu/055116nu/all_changed/path1" 2025/02/20 05:51:16 DEBUG : Creating backend with remote "/tmp/055116nu" 2025/02/20 05:51:16 DEBUG : Creating backend with remote "/tmp/055116nu/all_changed/path2" 2025/02/20 05:51:16 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial" 2025/02/20 05:51:16 DEBUG : Creating backend with remote "/tmp/055116nu/initdir/test_all_changed-nelited0" 2025/02/20 05:51:16 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : subdir: Making directory with metadata 2025/02/20 05:51:16 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/02/20 05:51:16 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/02/20 05:51:16 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:16 DEBUG : Local file system at /tmp/055116nu/initdir/test_all_changed-nelited0: Waiting for checks to finish 2025/02/20 05:51:16 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt 2025/02/20 05:51:16 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/02/20 05:51:16 INFO : file1.copy3.txt: Copied (new) 2025/02/20 05:51:16 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt 2025/02/20 05:51:16 INFO : file1.copy1.txt: Copied (new) 2025/02/20 05:51:16 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/02/20 05:51:16 INFO : RCLONE_TEST: Copied (new) 2025/02/20 05:51:16 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt 2025/02/20 05:51:16 INFO : file1.copy4.txt: Copied (new) 2025/02/20 05:51:16 DEBUG : Local file system at /tmp/055116nu/initdir/test_all_changed-nelited0: Waiting for transfers to finish 2025/02/20 05:51:16 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt 2025/02/20 05:51:16 INFO : file1.copy2.txt: Copied (new) 2025/02/20 05:51:16 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt 2025/02/20 05:51:16 INFO : file1.copy5.txt: Copied (new) 2025/02/20 05:51:16 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:16 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2025/02/20 05:51:16 INFO : subdir/file20.txt: Copied (new) 2025/02/20 05:51:16 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/02/20 05:51:16 INFO : file1.txt: Copied (new) 2025/02/20 05:51:16 INFO : subdir: Set directory modification time (using SetModTime) 2025/02/20 05:51:17 ERROR : : error listing: directory not found 2025/02/20 05:51:17 NOTICE: checking initFs Local file system at /tmp/055116nu/initdir/test_all_changed-nelited0 2025/02/20 05:51:17 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 INFO : subdir: Making directory 2025/02/20 05:51:17 DEBUG : subdir/: Creating directory marker 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/02/20 05:51:17 DEBUG : Azure container rclone-test-daseten1pilu path 055116nu/all_changed/path1: Waiting for checks to finish 2025/02/20 05:51:17 DEBUG : Azure container rclone-test-daseten1pilu path 055116nu/all_changed/path1: Waiting for transfers to finish 2025/02/20 05:51:17 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : file1.copy1.txt: Copied (new) 2025/02/20 05:51:17 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : file1.copy2.txt: Copied (new) 2025/02/20 05:51:17 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : file1.copy3.txt: Copied (new) 2025/02/20 05:51:17 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/02/20 05:51:17 INFO : RCLONE_TEST: Copied (new) 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : /: Creating directory marker 2025/02/20 05:51:17 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : subdir/file20.txt: Copied (new) 2025/02/20 05:51:17 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : file1.copy4.txt: Copied (new) 2025/02/20 05:51:17 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : file1.copy5.txt: Copied (new) 2025/02/20 05:51:17 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/02/20 05:51:17 INFO : file1.txt: Copied (new) 2025/02/20 05:51:17 NOTICE: checking Path1 Azure container rclone-test-daseten1pilu path 055116nu/all_changed/path1 --- FAIL: TestBisyncRemoteLocal (1.23s) --- FAIL: TestBisyncRemoteLocal/all_changed (1.23s) 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({0x242c3a0, 0xc0008b18f0}) /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({0x242c3a0?, 0xc0008b18f0?}) /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/azureblob.(*Fs).list(0xc0008d0508, {0x2a334a0, 0x3db9720}, {0xc000060800, 0x18}, {0xc000060819, 0x1a}, {0xc000060819, 0x1a}, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/azureblob/azureblob.go:1203 +0xc45 github.com/rclone/rclone/backend/azureblob.(*Fs).ListR.func1({0xc000060800?, 0xc000060800?}, {0xc000060819?, 0x7f501453aeb8?}, {0xc000060819?, 0xc000c6b548?}, 0x8f?) /home/rclone/go/src/github.com/rclone/rclone/backend/azureblob/azureblob.go:1368 +0xb3 github.com/rclone/rclone/backend/azureblob.(*Fs).ListR(0xc0008d0508, {0x2a334a0, 0x3db9720}, {0x0?, 0x24f9400?}, 0xc0008d2820) /home/rclone/go/src/github.com/rclone/rclone/backend/azureblob/azureblob.go:1398 +0x192 github.com/rclone/rclone/fs/walk.listR({0x2a334a0, 0x3db9720}, {0x2a47168, 0xc0008d0508}, {0x0, 0x0}, 0x1, 0x3, 0xc000a6a708, 0xc000c04660, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:298 +0x2a3 github.com/rclone/rclone/fs/walk.ListR({0x2a334a0, 0x3db9720}, {0x2a47168, 0xc0008d0508}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc000a6a708) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:162 +0x1d5 github.com/rclone/rclone/fs/walk.GetAll({0x2a334a0, 0x3db9720}, {0x2a47168, 0xc0008d0508}, {0x0, 0x0}, 0x1, 0xffffffffffffffff) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:631 +0x105 github.com/rclone/rclone/fstest.CheckListingWithRoot(0xc00074a000, {0x2a47168, 0xc0008d0508}, {0x0, 0x0}, {0xc000689340, 0x8, 0x8}, {0xc00081ae20, 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(0xc000882700, {0x2a334a0, 0x3db9720}, 0x604?, {0xc00073e0a5?, 0x54e700?}) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:460 +0x101c github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0xc00074a000) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358 +0x234 testing.tRunner(0xc00074a000, 0xc000738ae0) /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 23 /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 'TestAzureBlob,directory_markers:' -verbose" - Finished ERROR in 1.270828181s (try 1/5): exit status 2: Failed [TestBisyncRemoteLocal/all_changed]