"./bisync.test -test.v -test.timeout 1h0m0s -remote 'TestAzureBlob,directory_markers:' -verbose" - Starting (try 1/5) 2025/04/22 01:03:52 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-wotakod1mife" 2025/04/22 01:03:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/22 01:03:52 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/04/22 01:03:52 DEBUG : Azure container rclone-test-wotakod1mife: Using directory markers 2025/04/22 01:03:52 DEBUG : Creating backend with remote "/tmp/rclone3231942180" === RUN TestBisyncRemoteLocal 2025/04/22 01:03:52 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-zofuhik1tuti" 2025/04/22 01:03:52 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/04/22 01:03:52 DEBUG : Azure container rclone-test-zofuhik1tuti: Using directory markers 2025/04/22 01:03:52 NOTICE: remote: TestAzureBlob,directory_markers:rclone-test-zofuhik1tuti === RUN TestBisyncRemoteLocal/all_changed 2025/04/22 01:03:52 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-zofuhik1tuti/010352ci" 2025/04/22 01:03:52 DEBUG : Using config file from "/home/rclone/.rclone.conf" 2025/04/22 01:03:52 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/04/22 01:03:52 DEBUG : Azure container rclone-test-zofuhik1tuti path 010352ci: Using directory markers 2025/04/22 01:03:52 DEBUG : fs cache: renaming cache item "TestAzureBlob,directory_markers:rclone-test-zofuhik1tuti/010352ci" to be canonical "TestAzureBlob{juk_h}:rclone-test-zofuhik1tuti/010352ci" 2025/04/22 01:03:52 INFO : path1: Making directory 2025/04/22 01:03:52 DEBUG : path1/: Creating directory marker 2025/04/22 01:03:52 DEBUG : Creating backend with remote "TestAzureBlob,directory_markers:rclone-test-zofuhik1tuti/010352ci/all_changed/path1" 2025/04/22 01:03:52 DEBUG : TestAzureBlob: detected overridden config - adding "{juk_h}" suffix to name 2025/04/22 01:03:52 DEBUG : Azure container rclone-test-zofuhik1tuti path 010352ci/all_changed/path1: Using directory markers 2025/04/22 01:03:52 DEBUG : fs cache: renaming cache item "TestAzureBlob,directory_markers:rclone-test-zofuhik1tuti/010352ci/all_changed/path1" to be canonical "TestAzureBlob{juk_h}:rclone-test-zofuhik1tuti/010352ci/all_changed/path1" 2025/04/22 01:03:52 DEBUG : Creating backend with remote "/tmp/010352ci" 2025/04/22 01:03:52 DEBUG : Creating backend with remote "/tmp/010352ci/all_changed/path2" 2025/04/22 01:03:52 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial" 2025/04/22 01:03:52 DEBUG : Creating backend with remote "/tmp/010352ci/initdir/test_all_changed-sinuyep2" 2025/04/22 01:03:52 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : subdir: Making directory with metadata 2025/04/22 01:03:52 INFO : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z) 2025/04/22 01:03:52 DEBUG : Added delayed dir = "subdir", newDst=subdir 2025/04/22 01:03:52 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:52 DEBUG : Local file system at /tmp/010352ci/initdir/test_all_changed-sinuyep2: Waiting for checks to finish 2025/04/22 01:03:52 DEBUG : Local file system at /tmp/010352ci/initdir/test_all_changed-sinuyep2: Waiting for transfers to finish 2025/04/22 01:03:52 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/04/22 01:03:52 DEBUG : file1.copy1.txt.5028a97.partial: renamed to: file1.copy1.txt 2025/04/22 01:03:52 INFO : file1.copy1.txt: Copied (new) 2025/04/22 01:03:52 DEBUG : RCLONE_TEST.cf9a93ac.partial: renamed to: RCLONE_TEST 2025/04/22 01:03:52 INFO : RCLONE_TEST: Copied (new) 2025/04/22 01:03:52 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : file1.copy4.txt.5028a97.partial: renamed to: file1.copy4.txt 2025/04/22 01:03:52 INFO : file1.copy4.txt: Copied (new) 2025/04/22 01:03:52 DEBUG : file1.copy2.txt.5028a97.partial: renamed to: file1.copy2.txt 2025/04/22 01:03:52 INFO : file1.copy2.txt: Copied (new) 2025/04/22 01:03:52 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : file1.copy5.txt.5028a97.partial: renamed to: file1.copy5.txt 2025/04/22 01:03:52 INFO : file1.copy5.txt: Copied (new) 2025/04/22 01:03:52 DEBUG : file1.copy3.txt.5028a97.partial: renamed to: file1.copy3.txt 2025/04/22 01:03:52 INFO : file1.copy3.txt: Copied (new) 2025/04/22 01:03:52 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : subdir/file20.txt.5028a97.partial: renamed to: subdir/file20.txt 2025/04/22 01:03:52 INFO : subdir/file20.txt: Copied (new) 2025/04/22 01:03:52 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:52 DEBUG : file1.txt.5028a97.partial: renamed to: file1.txt 2025/04/22 01:03:52 INFO : file1.txt: Copied (new) 2025/04/22 01:03:52 INFO : subdir: Set directory modification time (using SetModTime) 2025/04/22 01:03:53 ERROR : : error listing: directory not found 2025/04/22 01:03:53 NOTICE: checking initFs Local file system at /tmp/010352ci/initdir/test_all_changed-sinuyep2 2025/04/22 01:03:53 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : file1.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 INFO : subdir: Making directory 2025/04/22 01:03:53 DEBUG : subdir/: Creating directory marker 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination 2025/04/22 01:03:53 DEBUG : Azure container rclone-test-zofuhik1tuti path 010352ci/all_changed/path1: Waiting for checks to finish 2025/04/22 01:03:53 DEBUG : Azure container rclone-test-zofuhik1tuti path 010352ci/all_changed/path1: Waiting for transfers to finish 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : file1.copy1.txt: Copied (new) 2025/04/22 01:03:53 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK 2025/04/22 01:03:53 INFO : RCLONE_TEST: Copied (new) 2025/04/22 01:03:53 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : file1.copy3.txt: Copied (new) 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : file1.copy2.txt: Copied (new) 2025/04/22 01:03:53 DEBUG : /: Creating directory marker 2025/04/22 01:03:53 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : subdir/file20.txt: Copied (new) 2025/04/22 01:03:53 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : file1.copy4.txt: Copied (new) 2025/04/22 01:03:53 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : file1.copy5.txt: Copied (new) 2025/04/22 01:03:53 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK 2025/04/22 01:03:53 INFO : file1.txt: Copied (new) 2025/04/22 01:03:53 NOTICE: checking Path1 Azure container rclone-test-zofuhik1tuti path 010352ci/all_changed/path1 --- FAIL: TestBisyncRemoteLocal (1.46s) --- FAIL: TestBisyncRemoteLocal/all_changed (1.45s) panic: runtime error: slice bounds out of range [27:26] [recovered] panic: runtime error: slice bounds out of range [27:26] goroutine 27 [running]: testing.tRunner.func1.2({0x24b1740, 0xc00069d140}) /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({0x24b1740?, 0xc00069d140?}) /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/azureblob.(*Fs).list(0xc00082e508, {0x2abb1a0, 0x3e631a0}, {0xc0006be200, 0x18}, {0xc0006be219, 0x1a}, {0xc0006be219, 0x1a}, 0x0, ...) /home/rclone/go/src/github.com/rclone/rclone/backend/azureblob/azureblob.go:1218 +0xc45 github.com/rclone/rclone/backend/azureblob.(*Fs).ListR.func1({0xc0006be200?, 0xc0006be200?}, {0xc0006be219?, 0x10000deb540?}, {0xc0006be219?, 0x47233d?}, 0x8?) /home/rclone/go/src/github.com/rclone/rclone/backend/azureblob/azureblob.go:1383 +0xa5 github.com/rclone/rclone/backend/azureblob.(*Fs).ListR(0xc00082e508, {0x2abb1a0, 0x3e631a0}, {0x0?, 0x257f760?}, 0xc0000bd770) /home/rclone/go/src/github.com/rclone/rclone/backend/azureblob/azureblob.go:1413 +0x172 github.com/rclone/rclone/fs/walk.listR({0x2abb1a0, 0x3e631a0}, {0x2acff30, 0xc00082e508}, {0x0, 0x0}, 0x1, 0x3, 0xc000a1ec30, 0xc000b04810, ...) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:299 +0x2a3 github.com/rclone/rclone/fs/walk.ListR({0x2abb1a0, 0x3e631a0}, {0x2acff30, 0xc00082e508}, {0x0, 0x0}, 0x1, 0xffffffffffffffff, 0x3, 0xc000a1ec30) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:163 +0x1d5 github.com/rclone/rclone/fs/walk.GetAll({0x2abb1a0, 0x3e631a0}, {0x2acff30, 0xc00082e508}, {0x0, 0x0}, 0x1, 0xffffffffffffffff) /home/rclone/go/src/github.com/rclone/rclone/fs/walk/walk.go:634 +0x105 github.com/rclone/rclone/fstest.CheckListingWithRoot(0xc0006b2000, {0x2acff30, 0xc00082e508}, {0x0, 0x0}, {0xc000957500, 0x8, 0x8}, {0xc000c896b0, 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(0xc0006b81c0, {0x2abb1a0, 0x3e631a0}, 0x605?, {0xc0007101b5?, 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(0xc0006b2000) /home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:358 +0x234 testing.tRunner(0xc0006b2000, 0xc0006a46c0) /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 37 /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 'TestAzureBlob,directory_markers:' -verbose" - Finished ERROR in 1.523841343s (try 1/5): exit status 2: Failed [TestBisyncRemoteLocal/all_changed]