"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Starting (try 1/5)
2026/04/02 04:23:27 DEBUG : Creating backend with remote "TestPcloud:rclone-test-tabeyim8cuga"
2026/04/02 04:23:27 DEBUG : Using config file from "/home/rclone/.rclone.conf"
2026/04/02 04:28:27 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=0": net/http: timeout awaiting response headers)
2026/04/02 04:28:27 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/04/02 04:33:28 DEBUG : pacer: low level retry 2/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=0": net/http: timeout awaiting response headers)
2026/04/02 04:33:28 DEBUG : pacer: Rate limited, increasing sleep to 40ms
2026/04/02 04:38:28 DEBUG : pacer: low level retry 3/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=0": net/http: timeout awaiting response headers)
2026/04/02 04:38:28 DEBUG : pacer: Rate limited, increasing sleep to 80ms
2026/04/02 04:38:29 DEBUG : pacer: Reducing sleep to 60ms
2026/04/02 04:38:29 DEBUG : Creating backend with remote "/tmp/rclone1080746090"
2026/04/02 04:38:29 DEBUG : Config file has changed externally - reloading
=== RUN   TestLockfileIsExpired_UnreadableWithMaxLock
2026/04/02 04:38:29 INFO  : /tmp/TestLockfileIsExpired_UnreadableWithMaxLock1861868596/001/test.lck: Lock file is unreadable (decode error: invalid character 'o' in literal null (expecting 'u')) and --max-lock is set. Treating as expired.
--- PASS: TestLockfileIsExpired_UnreadableWithMaxLock (0.00s)
=== RUN   TestLockfileIsExpired_UnreadableWithoutMaxLock
2026/04/02 04:38:29 ERROR : /tmp/TestLockfileIsExpired_UnreadableWithoutMaxLock3210931278/001/test.lck: Lock file exists, but contents are unreadable. (decode error: invalid character 'o' in literal null (expecting 'u'))
--- PASS: TestLockfileIsExpired_UnreadableWithoutMaxLock (0.00s)
=== RUN   TestLockfileIsExpired_ValidExpired
2026/04/02 04:38:29 INFO  : /tmp/TestLockfileIsExpired_ValidExpired3610853412/001/test.lck: Lock file found, but it expired at 2026-04-02 04:33:29.553695887 +0000 UTC. Will delete it and proceed.
--- PASS: TestLockfileIsExpired_ValidExpired (0.00s)
=== RUN   TestLockfileIsExpired_ValidNotExpired
2026/04/02 04:38:29 INFO  : /tmp/TestLockfileIsExpired_ValidNotExpired2655333990/001/test.lck: Valid lock file found. Expires at 2026-04-02 04:48:29.554246596 +0000 UTC. (10m0s from now)
2026/04/02 04:38:29 INFO  : Lockfile info: 
{
	"Session": "test",
	"PID": "12345",
	"TimeRenewed": "2026-04-02T04:38:29.554246516Z",
	"TimeExpires": "2026-04-02T04:48:29.554246596Z"
}
--- PASS: TestLockfileIsExpired_ValidNotExpired (0.00s)
=== RUN   TestBisyncRemoteLocal
2026/04/02 04:38:29 DEBUG : Creating backend with remote "TestPcloud:rclone-test-tonadux8jero"
2026/04/02 04:38:34 NOTICE: remote: TestPcloud:rclone-test-tonadux8jero
=== RUN   TestBisyncRemoteLocal/all_changed
2026/04/02 04:38:34 DEBUG : Creating backend with remote "TestPcloud:rclone-test-tonadux8jero/043834ye"
2026/04/02 04:42:41 INFO  : path1: Making directory
2026/04/02 04:51:31 DEBUG : pacer: low level retry 1/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=0&name=rclone-test-tonadux8jero": net/http: timeout awaiting response headers)
2026/04/02 04:51:31 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/04/02 04:51:53 DEBUG : pacer: Reducing sleep to 15ms
2026/04/02 04:53:38 DEBUG : pacer: Reducing sleep to 11.25ms
2026/04/02 04:58:38 DEBUG : pacer: low level retry 1/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=23219142701&name=043834ye": net/http: timeout awaiting response headers)
2026/04/02 04:58:38 DEBUG : pacer: Rate limited, increasing sleep to 22.5ms
2026/04/02 05:03:38 DEBUG : pacer: low level retry 2/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=23219142701&name=043834ye": net/http: timeout awaiting response headers)
2026/04/02 05:03:38 DEBUG : pacer: Rate limited, increasing sleep to 45ms
2026/04/02 05:03:41 DEBUG : pacer: Reducing sleep to 33.75ms
2026/04/02 05:08:41 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=23219155365": net/http: timeout awaiting response headers)
2026/04/02 05:08:41 DEBUG : pacer: Rate limited, increasing sleep to 67.5ms
2026/04/02 05:08:41 DEBUG : pacer: Reducing sleep to 50.625ms
2026/04/02 05:13:41 DEBUG : pacer: low level retry 1/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=23219155365&name=path1": net/http: timeout awaiting response headers)
2026/04/02 05:13:41 DEBUG : pacer: Rate limited, increasing sleep to 101.25ms
2026/04/02 05:18:41 DEBUG : pacer: low level retry 2/10 (error Post "https://eapi.pcloud.com/createfolder?folderid=23219155365&name=path1": net/http: timeout awaiting response headers)
2026/04/02 05:18:41 DEBUG : pacer: Rate limited, increasing sleep to 202.5ms
2026/04/02 05:18:41 DEBUG : pacer: Reducing sleep to 151.875ms
2026/04/02 05:18:41 DEBUG : Creating backend with remote "TestPcloud:rclone-test-tonadux8jero/043834ye/all_changed/path1"
2026/04/02 05:18:41 DEBUG : Config file has changed externally - reloading
2026/04/02 05:23:59 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=23219142701": net/http: timeout awaiting response headers)
2026/04/02 05:23:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/04/02 05:23:59 DEBUG : pacer: Reducing sleep to 15ms
2026/04/02 05:23:59 DEBUG : pacer: Reducing sleep to 11.25ms
2026/04/02 05:23:59 DEBUG : Creating backend with remote "/tmp/043834ye"
2026/04/02 05:23:59 DEBUG : Config file has changed externally - reloading
2026/04/02 05:23:59 DEBUG : Creating backend with remote "/tmp/043834ye/all_changed/path2"
2026/04/02 05:23:59 DEBUG : Creating backend with remote "/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/testdata/test_all_changed/initial"
2026/04/02 05:23:59 DEBUG : Creating backend with remote "/tmp/043834ye/initdir/test_all_changed-hikigam4"
2026/04/02 05:23:59 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : subdir: Making directory with metadata
2026/04/02 05:23:59 INFO  : subdir: Made directory with metadata (mtime=2021-11-02T05:00:07Z)
2026/04/02 05:23:59 DEBUG : Added delayed dir = "subdir", newDst=subdir
2026/04/02 05:23:59 DEBUG : subdir/file20.txt: Need to transfer - File not found at Destination
2026/04/02 05:23:59 DEBUG : file1.copy1.txt.21b8fa2b.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : file1.copy2.txt.455881d5.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : RCLONE_TEST.abb09051.partial: size = 109 OK
2026/04/02 05:23:59 DEBUG : file1.copy3.txt.d0285540.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : Local file system at /tmp/043834ye/initdir/test_all_changed-hikigam4: Waiting for checks to finish
2026/04/02 05:23:59 DEBUG : file1.copy1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : Local file system at /tmp/043834ye/initdir/test_all_changed-hikigam4: Waiting for transfers to finish
2026/04/02 05:23:59 DEBUG : RCLONE_TEST: md5 = 294d25b294ff26a5243dba914ac3fbf7 OK
2026/04/02 05:23:59 DEBUG : file1.copy1.txt.21b8fa2b.partial: renamed to: file1.copy1.txt
2026/04/02 05:23:59 INFO  : file1.copy1.txt: Copied (new)
2026/04/02 05:23:59 DEBUG : RCLONE_TEST.abb09051.partial: renamed to: RCLONE_TEST
2026/04/02 05:23:59 INFO  : RCLONE_TEST: Copied (new)
2026/04/02 05:23:59 DEBUG : file1.copy4.txt.8c987629.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : file1.copy3.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : file1.copy5.txt.19e8a2bc.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : file1.copy3.txt.d0285540.partial: renamed to: file1.copy3.txt
2026/04/02 05:23:59 INFO  : file1.copy3.txt: Copied (new)
2026/04/02 05:23:59 DEBUG : file1.copy5.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : file1.copy2.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : file1.copy4.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : file1.copy2.txt.455881d5.partial: renamed to: file1.copy2.txt
2026/04/02 05:23:59 DEBUG : file1.copy5.txt.19e8a2bc.partial: renamed to: file1.copy5.txt
2026/04/02 05:23:59 DEBUG : file1.copy4.txt.8c987629.partial: renamed to: file1.copy4.txt
2026/04/02 05:23:59 INFO  : file1.copy4.txt: Copied (new)
2026/04/02 05:23:59 INFO  : file1.copy5.txt: Copied (new)
2026/04/02 05:23:59 INFO  : file1.copy2.txt: Copied (new)
2026/04/02 05:23:59 DEBUG : subdir/file20.txt.1ac3db2f.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : subdir/file20.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : file1.txt.56d0d699.partial: size = 0 OK
2026/04/02 05:23:59 DEBUG : subdir/file20.txt.1ac3db2f.partial: renamed to: subdir/file20.txt
2026/04/02 05:23:59 INFO  : subdir/file20.txt: Copied (new)
2026/04/02 05:23:59 DEBUG : file1.txt: md5 = d41d8cd98f00b204e9800998ecf8427e OK
2026/04/02 05:23:59 DEBUG : file1.txt.56d0d699.partial: renamed to: file1.txt
2026/04/02 05:23:59 INFO  : file1.txt: Copied (new)
2026/04/02 05:23:59 INFO  : subdir: Set directory modification time (using SetModTime)
2026/04/02 05:23:59 DEBUG : pacer: Reducing sleep to 10ms
2026/04/02 05:23:59 DEBUG : Waiting for deletions to finish
2026/04/02 05:23:59 ERROR : error listing: directory not found
2026/04/02 05:23:59 ERROR : Local file system at /tmp/043834ye/all_changed/path2: Failed to list "": directory not found
2026/04/02 05:23:59 DEBUG : removing 1 level 0 directories
2026/04/02 05:23:59 INFO  : Local file system at /tmp/043834ye/all_changed/path2: Removing directory
2026/04/02 05:23:59 ERROR : Failed to rmdir: stat /tmp/043834ye/all_changed/path2: no such file or directory
2026/04/02 05:28:59 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=23219155365": net/http: timeout awaiting response headers)
2026/04/02 05:28:59 DEBUG : pacer: Rate limited, increasing sleep to 20ms
2026/04/02 05:29:00 DEBUG : pacer: Reducing sleep to 15ms
2026/04/02 05:29:00 ERROR : error listing: directory not found
2026/04/02 05:29:00 DEBUG : Creating backend with remote "/tmp/043834ye/initdir/test_all_changed-hikigam4"
2026/04/02 05:29:00 DEBUG : Config file has changed externally - reloading
2026/04/02 05:29:00 NOTICE: checking initFs Local file system at /tmp/043834ye/initdir/test_all_changed-hikigam4
2026/04/02 05:29:01 DEBUG : pacer: Reducing sleep to 11.25ms
2026/04/02 05:29:01 DEBUG : RCLONE_TEST: Need to transfer - File not found at Destination
2026/04/02 05:29:01 DEBUG : file1.copy1.txt: Need to transfer - File not found at Destination
2026/04/02 05:29:01 DEBUG : file1.copy2.txt: Need to transfer - File not found at Destination
2026/04/02 05:29:01 DEBUG : file1.copy3.txt: Need to transfer - File not found at Destination
2026/04/02 05:29:01 DEBUG : file1.copy4.txt: Need to transfer - File not found at Destination
2026/04/02 05:29:01 DEBUG : file1.copy5.txt: Need to transfer - File not found at Destination
2026/04/02 05:29:01 DEBUG : file1.txt: Need to transfer - File not found at Destination
2026/04/02 05:29:01 INFO  : subdir: Making directory
2026/04/02 05:34:01 DEBUG : pacer: low level retry 1/10 (error Get "https://eapi.pcloud.com/listfolder?folderid=23219155365": net/http: timeout awaiting response headers)
2026/04/02 05:34:01 DEBUG : pacer: Rate limited, increasing sleep to 22.5ms
panic: test timed out after 1h0m0s
	running tests:
		TestBisyncRemoteLocal (1h0m0s)
		TestBisyncRemoteLocal/all_changed (59m55s)

goroutine 457 [running]:
testing.(*M).startAlarm.func1()
	/usr/local/go/src/testing/testing.go:2802 +0x34b
created by time.goFunc
	/usr/local/go/src/time/sleep.go:215 +0x2d

goroutine 1 [chan receive, 60 minutes]:
testing.(*T).Run(0x2c3dc39be6c8, {0x2a41cf5?, 0x2c3dc3a876f0?}, 0x2bac6a0)
	/usr/local/go/src/testing/testing.go:2109 +0x4e5
testing.runTests.func1(0x2c3dc39be6c8)
	/usr/local/go/src/testing/testing.go:2585 +0x37
testing.tRunner(0x2c3dc39be6c8, 0x2c3dc3a87818)
	/usr/local/go/src/testing/testing.go:2036 +0xea
testing.runTests({0x2a4d3de, 0x18}, {0x2a7b13b, 0x23}, 0x2c3dc3c877d0, {0x4632ae0, 0x8, 0x8}, {0xc26b9e1560f0203d, 0x4184c74bf88, ...})
	/usr/local/go/src/testing/testing.go:2583 +0x505
testing.(*M).Run(0x2c3dc3874640)
	/usr/local/go/src/testing/testing.go:2443 +0x6ac
github.com/rclone/rclone/fstest.TestMain(0x2c3dc3874640)
	/home/rclone/go/src/github.com/rclone/rclone/fstest/run.go:74 +0xa6
github.com/rclone/rclone/cmd/bisync_test.TestMain(0x2c3dc3874640)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:243 +0x12b
main.main()
	_testmain.go:64 +0xa5

goroutine 456 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0x2c3dc3ab6d00)
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:222 +0xec
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 421
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:120 +0x43f

goroutine 53 [syscall, 75 minutes]:
os/signal.signal_recv()
	/usr/local/go/src/runtime/sigqueue.go:152 +0x98
os/signal.loop()
	/usr/local/go/src/os/signal/signal_unix.go:23 +0x13
created by os/signal.Notify.func1.1 in goroutine 1
	/usr/local/go/src/os/signal/signal.go:152 +0x1f

goroutine 443 [IO wait, 5 minutes]:
internal/poll.runtime_pollWait(0x70416c4cb800, 0x72)
	/usr/local/go/src/runtime/netpoll.go:351 +0x85
internal/poll.(*pollDesc).wait(0x2c3dc365e280?, 0x2c3dc3498600?, 0x0)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:84 +0x27
internal/poll.(*pollDesc).waitRead(...)
	/usr/local/go/src/internal/poll/fd_poll_runtime.go:89
internal/poll.(*FD).Read(0x2c3dc365e280, {0x2c3dc3498600, 0x1980, 0x1980})
	/usr/local/go/src/internal/poll/fd_unix.go:165 +0x2ae
net.(*netFD).Read(0x2c3dc365e280, {0x2c3dc3498600?, 0x197b?, 0x2c3dc39dc220?})
	/usr/local/go/src/net/fd_posix.go:68 +0x25
net.(*conn).Read(0x2c3dc32b42d0, {0x2c3dc3498600?, 0x2c3dc3498600?, 0x5?})
	/usr/local/go/src/net/net.go:196 +0x45
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0x2c3dc32c42e8, {0x2c3dc3498600?, 0x70416912dcc0?, 0x7041b318bbf0?})
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/dialer.go:111 +0x29
crypto/tls.(*atLeastReader).Read(0x2c3dc3b902e8, {0x2c3dc3498600?, 0x197b?, 0x2c3dc3b43a98?})
	/usr/local/go/src/crypto/tls/conn.go:815 +0x3b
bytes.(*Buffer).ReadFrom(0x2c3dc34aa2a8, {0x2bca040, 0x2c3dc3b902e8})
	/usr/local/go/src/bytes/buffer.go:229 +0x98
crypto/tls.(*Conn).readFromUntil(0x2c3dc34aa008, {0x704169149000, 0x2c3dc32c42e8}, 0x2c3dc3a041f9?)
	/usr/local/go/src/crypto/tls/conn.go:837 +0xde
crypto/tls.(*Conn).readRecordOrCCS(0x2c3dc34aa008, 0x0)
	/usr/local/go/src/crypto/tls/conn.go:626 +0x3db
crypto/tls.(*Conn).readRecord(...)
	/usr/local/go/src/crypto/tls/conn.go:588
crypto/tls.(*Conn).Read(0x2c3dc34aa008, {0x2c3dc35a3000, 0x1000, 0x70?})
	/usr/local/go/src/crypto/tls/conn.go:1393 +0x145
net/http.(*persistConn).Read(0x2c3dc3918780, {0x2c3dc35a3000?, 0x70?, 0x0?})
	/usr/local/go/src/net/http/transport.go:2174 +0x47
bufio.(*Reader).fill(0x2c3dc336d740)
	/usr/local/go/src/bufio/bufio.go:113 +0x103
bufio.(*Reader).Peek(0x2c3dc336d740, 0x1)
	/usr/local/go/src/bufio/bufio.go:152 +0x53
net/http.(*persistConn).readLoop(0x2c3dc3918780)
	/usr/local/go/src/net/http/transport.go:2330 +0x172
created by net/http.(*Transport).dialConn in goroutine 469
	/usr/local/go/src/net/http/transport.go:1994 +0x16ac

goroutine 54 [chan receive, 75 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7

goroutine 55 [chan receive, 75 minutes]:
github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:24 +0x27
created by github.com/rclone/rclone/fs/accounting.(*tokenBucket).startSignalHandler in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting_unix.go:21 +0xa7

goroutine 56 [select, 75 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0x2c3dc3a7a6c0)
	/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x85
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 1
	/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5

goroutine 423 [sync.Mutex.Lock, 9 minutes]:
internal/sync.runtime_SemacquireMutex(0x42734a?, 0x29?, 0x427694?)
	/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0x2c3dc37a18e8)
	/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
	/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
	/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x0, 0x0}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7e
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc39912c0?, 0x2c3dc3b46950?}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/pcloud.(*Fs).createObject(0x2c3dc36a8840, {0x2bf2968?, 0x2c3dc3891590?}, {0x2c3dc39912c0, 0x20}, {0x20?, 0x282c8c0?, 0x42441f?}, 0x26c9420?)
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:681 +0x45
github.com/rclone/rclone/backend/pcloud.(*Fs).Put(0x2c3dc36a8840, {0x2bf2968, 0x2c3dc3891590}, {0x2bc7160, 0x2c3dc32ae800}, {0x2c039c0, 0x2c3dc39dc5e0}, {0x2c3dc3b04d80, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:703 +0xd7
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0x2c3dc34498c0, {0x2bf2968, 0x2c3dc3891590}, {0x2bdc488?, 0x2c3dc37a2690?}, {0x2c3dc3b04d80, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:229 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0x2c3dc34498c0, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:282 +0x6f6
github.com/rclone/rclone/fs/operations.(*copy).copy(0x2c3dc34498c0, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:322 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2bf2968, 0x2c3dc3891590}, {0x2c10840, 0x2c3dc36a8840}, {0x0, 0x0}, {0x2c3dc3b020e0, 0xf}, {0x2c101b0, 0x2c3dc3cdc0c0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:424 +0x4dc
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0x2c3dc3a12008, {0x2bf2968, 0x2c3dc3891590}, 0x2c3dc38914f0, {0x2c10840, 0x2c3dc36a8840}, 0x4b, 0x2c3dc33387b8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d

goroutine 41 [chan receive, 60 minutes]:
testing.(*T).Run(0x2c3dc39bf208, {0x2c3dc3972af5?, 0x2bb3398?}, 0x2c3dc3d35260)
	/usr/local/go/src/testing/testing.go:2109 +0x4e5
github.com/rclone/rclone/cmd/bisync_test.testBisync({0x2bf2930, 0x2c3dc34f5170}, 0x2c3dc39bf208, {0x2c3dc393d980, 0x23}, {0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:398 +0x905
github.com/rclone/rclone/cmd/bisync_test.TestBisyncRemoteLocal(0x2c3dc39bf208)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:256 +0x175
testing.tRunner(0x2c3dc39bf208, 0x2bac6a0)
	/usr/local/go/src/testing/testing.go:2036 +0xea
created by testing.(*T).Run in goroutine 1
	/usr/local/go/src/testing/testing.go:2101 +0x4c5

goroutine 450 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0x2c3dc3ab6c00)
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:222 +0xec
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 420
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:120 +0x43f

goroutine 422 [sync.Mutex.Lock, 9 minutes]:
internal/sync.runtime_SemacquireMutex(0x42734a?, 0xba?, 0x427694?)
	/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0x2c3dc37a18e8)
	/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
	/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
	/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x0, 0x0}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7e
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3991340?, 0x2c3dc334d950?}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/pcloud.(*Fs).createObject(0x2c3dc36a8840, {0x2bf2968?, 0x2c3dc3891590?}, {0x2c3dc3991340, 0x20}, {0x20?, 0x282c8c0?, 0x42441f?}, 0x26c9420?)
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:681 +0x45
github.com/rclone/rclone/backend/pcloud.(*Fs).Put(0x2c3dc36a8840, {0x2bf2968, 0x2c3dc3891590}, {0x2bc7160, 0x2c3dc32aef00}, {0x2c039c0, 0x2c3dc39dc660}, {0x2c3dc3b04df0, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:703 +0xd7
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0x2c3dc3449950, {0x2bf2968, 0x2c3dc3891590}, {0x2bdc488?, 0x2c3dc37a2780?}, {0x2c3dc3b04df0, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:229 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0x2c3dc3449950, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:282 +0x6f6
github.com/rclone/rclone/fs/operations.(*copy).copy(0x2c3dc3449950, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:322 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2bf2968, 0x2c3dc3891590}, {0x2c10840, 0x2c3dc36a8840}, {0x0, 0x0}, {0x2c3dc3b02290, 0xf}, {0x2c101b0, 0x2c3dc3cdc300})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:424 +0x4dc
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0x2c3dc3a12008, {0x2bf2968, 0x2c3dc3891590}, 0x2c3dc38914f0, {0x2c10840, 0x2c3dc36a8840}, 0x32, 0x2c3dc3b3dfb8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d

goroutine 42 [select, 60 minutes]:
github.com/rclone/rclone/lib/oauthutil.(*Renew).renewOnExpiry(0x2c3dc37730c0)
	/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:43 +0x85
created by github.com/rclone/rclone/lib/oauthutil.NewRenew in goroutine 41
	/home/rclone/go/src/github.com/rclone/rclone/lib/oauthutil/renew.go:32 +0xe5

goroutine 367 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x25)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x25, 0x0?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 369 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x3e)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x3e, 0x2c3dc37c57b8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 29 [sync.WaitGroup.Wait, 9 minutes]:
sync.runtime_SemacquireWaitGroup(0x2c3dc39dc2a0?, 0x60?)
	/usr/local/go/src/runtime/sema.go:114 +0x2e
sync.(*WaitGroup).Wait(0x2c3dc39e6410)
	/usr/local/go/src/sync/waitgroup.go:206 +0x85
github.com/rclone/rclone/fs/march.(*March).Run(0x2c3dc34494d0, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:264 +0x366
github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0x2c3dc3a12008)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:952 +0x23d
github.com/rclone/rclone/fs/sync.runSyncCopyMove({0x2bf2930, 0x2c3dc35e57d0}, {0x2c10840, 0x2c3dc36a8840}, {0x2c10140, 0x2c3dc3466fc0}, 0x0, 0x0, 0x0, 0x1, ...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1365 +0x225
github.com/rclone/rclone/fs/sync.CopyDir(...)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1376
github.com/rclone/rclone/cmd/bisync_test.(*bisyncTest).runTestCase(0x2c3dc359a540, {0x2bf2930, 0x2c3dc3bbd830}, 0x755?, {0x2c3dc3972af5?, 0x56ebc0?})
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:506 +0xf71
github.com/rclone/rclone/cmd/bisync_test.testBisync.func4(0x2c3dc3a9e008)
	/home/rclone/go/src/github.com/rclone/rclone/cmd/bisync/bisync_test.go:405 +0x265
testing.tRunner(0x2c3dc3a9e008, 0x2c3dc3d35260)
	/usr/local/go/src/testing/testing.go:2036 +0xea
created by testing.(*T).Run in goroutine 41
	/usr/local/go/src/testing/testing.go:2101 +0x4c5

goroutine 444 [select, 5 minutes]:
net/http.(*persistConn).writeLoop(0x2c3dc3918780)
	/usr/local/go/src/net/http/transport.go:2652 +0xe6
created by net/http.(*Transport).dialConn in goroutine 469
	/usr/local/go/src/net/http/transport.go:1995 +0x16fe

goroutine 28 [chan receive, 60 minutes]:
github.com/rclone/rclone/lib/atexit.Register.func1.1()
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:45 +0x29
created by github.com/rclone/rclone/lib/atexit.Register.func1 in goroutine 41
	/home/rclone/go/src/github.com/rclone/rclone/lib/atexit/atexit.go:44 +0x68

goroutine 366 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x19)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x19, 0x2c3dc3810d80?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 365 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0xc)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0xc, 0x2c3dc3338fb8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 364 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x0)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x0, 0x2c3dc3950fb8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 368 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x32)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x32, 0x2c3dc3918dc0?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 209 [select]:
github.com/rclone/rclone/fs/accounting.(*StatsInfo).averageLoop(0x2c3dc3a1c3c0, {0x2bf2968, 0x2c3dc347a9b0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:352 +0x145
created by github.com/rclone/rclone/fs/accounting.(*StatsInfo)._startAverageLoop in goroutine 420
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/stats.go:389 +0x11d

goroutine 419 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x57)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x57, 0x2c3dc3951fb8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 418 [select, 9 minutes]:
github.com/rclone/rclone/fs/sync.(*pipe).GetMax(0x2c3dc38914a0, {0x2bf2968, 0x2c3dc38915e0}, 0x4b)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/pipe.go:126 +0xae
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairChecker(0x2c3dc3a12008, 0x2c3dc38914a0, 0x2c3dc38914f0, 0x4b, 0x2c3dc3b3cfb8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:374 +0xbe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startCheckers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:519 +0x67

goroutine 420 [select, 5 minutes]:
net/http.(*persistConn).roundTrip(0x2c3dc3918780, 0x2c3dc38900a0)
	/usr/local/go/src/net/http/transport.go:2911 +0x83d
net/http.(*Transport).roundTrip(0x2c3dc375e4e0, 0x2c3dc3918140)
	/usr/local/go/src/net/http/transport.go:704 +0xaba
net/http.(*Transport).RoundTrip(...)
	/usr/local/go/src/net/http/roundtrip.go:33
github.com/rclone/rclone/fs/fshttp.(*Transport).RoundTrip(0x2c3dc336dce0, 0x2c3dc3918140)
	/home/rclone/go/src/github.com/rclone/rclone/fs/fshttp/http.go:496 +0x34a
golang.org/x/oauth2.(*Transport).RoundTrip(0x2c3dc3845920, 0x2c3dc3918000)
	/home/rclone/go/pkg/mod/golang.org/x/oauth2@v0.35.0/transport.go:55 +0x15a
net/http.send(0x2c3dc3918000, {0x2bcac20, 0x2c3dc3845920}, {0x2c3dc331ea40?, 0x4936a6?, 0x0?})
	/usr/local/go/src/net/http/client.go:264 +0x64b
net/http.(*Client).send(0x2c3dc351f920, 0x2c3dc3918000, {0x2c3dc331ea78?, 0x431836?, 0x0?})
	/usr/local/go/src/net/http/client.go:185 +0x258
net/http.(*Client).do(0x2c3dc351f920, 0x2c3dc3918000)
	/usr/local/go/src/net/http/client.go:733 +0x9d7
net/http.(*Client).Do(...)
	/usr/local/go/src/net/http/client.go:592
github.com/rclone/rclone/lib/rest.(*Client).Call(0x2c3dc3890c80, {0x2bf2968, 0x2c3dc3891590}, 0x2c3dc3ce2000)
	/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:371 +0xd85
github.com/rclone/rclone/lib/rest.(*Client).callCodec(0x2c3dc3890c80, {0x2bf2968, 0x2c3dc3891590}, 0x23db8e0?, {0x0?, 0x0?}, {0x24cae60, 0x2c3dc3a6a360}, 0x41e885?, 0x2badf00, ...)
	/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:579 +0x447
github.com/rclone/rclone/lib/rest.(*Client).CallJSON(...)
	/home/rclone/go/src/github.com/rclone/rclone/lib/rest/rest.go:522
github.com/rclone/rclone/backend/pcloud.(*Fs).listAll.func1()
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:551 +0x8f
github.com/rclone/rclone/fs.pacerInvoker(0x2, 0xa, 0x2bc7060?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/pacer.go:86 +0x32
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0x2c3dc336dda0, 0x2c3dc3712780, 0xa)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:228 +0xd2
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0x2c3dc336dda0, 0x2c3dc3712780)
	/home/rclone/go/src/github.com/rclone/rclone/lib/pacer/pacer.go:247 +0x92
github.com/rclone/rclone/backend/pcloud.(*Fs).listAll(0x2c3dc36a8840, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3c13110, 0xc}, 0x1, 0x0, 0x0, 0x2c3dc331f6f0)
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:550 +0x3d9
github.com/rclone/rclone/backend/pcloud.(*Fs).FindLeaf(0x2c3dc37a18c0?, {0x2bf2968?, 0x2c3dc3891590?}, {0x2c3dc3c13110?, 0x21?}, {0x2c3dc3c2532d?, 0x2c3dc334f798?})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:471 +0x6e
github.com/rclone/rclone/lib/dircache.(*DirCache)._findDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3c2530b, 0x2d}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:234 +0x112
github.com/rclone/rclone/lib/dircache.(*DirCache)._findDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3c2530b, 0x33}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:227 +0xc5
github.com/rclone/rclone/lib/dircache.(*DirCache)._findRoot(0x2c3dc37a18c0, {0x2bf2968?, 0x2c3dc3891590?}, 0xe0?)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:305 +0x45
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x0, 0x0}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:201 +0xce
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3a8c7c0?, 0x2c3dc334f950?}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/pcloud.(*Fs).createObject(0x2c3dc36a8840, {0x2bf2968?, 0x2c3dc3891590?}, {0x2c3dc3a8c7c0, 0x1c}, {0x20?, 0x282c8c0?, 0x42441f?}, 0x26c9420?)
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:681 +0x45
github.com/rclone/rclone/backend/pcloud.(*Fs).Put(0x2c3dc36a8840, {0x2bf2968, 0x2c3dc3891590}, {0x2bc7160, 0x2c3dc3ab6c00}, {0x2c039c0, 0x2c3dc38441a0}, {0x2c3dc3bc4170, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:703 +0xd7
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0x2c3dc3be2000, {0x2bf2968, 0x2c3dc3891590}, {0x2bdc488?, 0x2c3dc39de5a0?}, {0x2c3dc3bc4170, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:229 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0x2c3dc3be2000, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:282 +0x6f6
github.com/rclone/rclone/fs/operations.(*copy).copy(0x2c3dc3be2000, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:322 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2bf2968, 0x2c3dc3891590}, {0x2c10840, 0x2c3dc36a8840}, {0x0, 0x0}, {0x2c3dc3b02230, 0xb}, {0x2c101b0, 0x2c3dc3cdc1e0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:424 +0x4dc
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0x2c3dc3a12008, {0x2bf2968, 0x2c3dc3891590}, 0x2c3dc38914f0, {0x2c10840, 0x2c3dc36a8840}, 0x0, 0x2c3dc3b40fb8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d

goroutine 421 [sync.Mutex.Lock, 9 minutes]:
internal/sync.runtime_SemacquireMutex(0x42734a?, 0x49?, 0x427694?)
	/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0x2c3dc37a18e8)
	/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
	/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
	/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x0, 0x0}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7e
github.com/rclone/rclone/lib/dircache.(*DirCache).FindPath(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3a8c940?, 0x2c3dc334f950?}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:275 +0xa9
github.com/rclone/rclone/backend/pcloud.(*Fs).createObject(0x2c3dc36a8840, {0x2bf2968?, 0x2c3dc3891590?}, {0x2c3dc3a8c940, 0x20}, {0x20?, 0x282c8c0?, 0x42441f?}, 0x26c9420?)
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:681 +0x45
github.com/rclone/rclone/backend/pcloud.(*Fs).Put(0x2c3dc36a8840, {0x2bf2968, 0x2c3dc3891590}, {0x2bc7160, 0x2c3dc3ab6d00}, {0x2c039c0, 0x2c3dc38443a0}, {0x2c3dc3bc4300, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:703 +0xd7
github.com/rclone/rclone/fs/operations.(*copy).updateOrPut(0x2c3dc3be22d0, {0x2bf2968, 0x2c3dc3891590}, {0x2bdc488?, 0x2c3dc39de690?}, {0x2c3dc3bc4300, 0x1, 0x1})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:229 +0x225
github.com/rclone/rclone/fs/operations.(*copy).manualCopy(0x2c3dc3be22d0, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:282 +0x6f6
github.com/rclone/rclone/fs/operations.(*copy).copy(0x2c3dc3be22d0, {0x2bf2968, 0x2c3dc3891590})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:322 +0x170
github.com/rclone/rclone/fs/operations.Copy({0x2bf2968, 0x2c3dc3891590}, {0x2c10840, 0x2c3dc36a8840}, {0x0, 0x0}, {0x2c3dc3b02270, 0xf}, {0x2c101b0, 0x2c3dc3cdc2a0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/copy.go:424 +0x4dc
github.com/rclone/rclone/fs/sync.(*syncCopyMove).pairCopyOrMove(0x2c3dc3a12008, {0x2bf2968, 0x2c3dc3891590}, 0x2c3dc38914f0, {0x2c10840, 0x2c3dc36a8840}, 0x19, 0x2c3dc3b3e7b8?)
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:505 +0x1fe
created by github.com/rclone/rclone/fs/sync.(*syncCopyMove).startTransfers in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:535 +0x7d

goroutine 424 [sync.Mutex.Lock, 9 minutes]:
internal/sync.runtime_SemacquireMutex(0x46971a0?, 0x26?, 0x10?)
	/usr/local/go/src/runtime/sema.go:95 +0x25
internal/sync.(*Mutex).lockSlow(0x2c3dc37a18e8)
	/usr/local/go/src/internal/sync/mutex.go:149 +0x15d
internal/sync.(*Mutex).Lock(...)
	/usr/local/go/src/internal/sync/mutex.go:70
sync.(*Mutex).Lock(...)
	/usr/local/go/src/sync/mutex.go:46
github.com/rclone/rclone/lib/dircache.(*DirCache).FindDir(0x2c3dc37a18c0, {0x2bf2968, 0x2c3dc3891590}, {0x2c3dc3b02048, 0x6}, 0x1)
	/home/rclone/go/src/github.com/rclone/rclone/lib/dircache/dircache.go:199 +0x7e
github.com/rclone/rclone/backend/pcloud.(*Fs).Mkdir(0x2c3dc3b02006?, {0x2bf2968?, 0x2c3dc3891590?}, {0x2c3dc3b02048?, 0x10?})
	/home/rclone/go/src/github.com/rclone/rclone/backend/pcloud/pcloud.go:712 +0x2f
github.com/rclone/rclone/fs/operations.Mkdir({0x2bf2968, 0x2c3dc3891590}, {0x2c10840, 0x2c3dc36a8840}, {0x2c3dc3b02048, 0x6})
	/home/rclone/go/src/github.com/rclone/rclone/fs/operations/operations.go:1058 +0x109
github.com/rclone/rclone/fs/sync.(*syncCopyMove).copyDirMetadata(0x2c3dc3a12008, {0x2bf2968, 0x2c3dc3891590}, {0x2c10840, 0x2c3dc36a8840}, {0x0, 0x0}, {0x2c3dc3b02048, 0x6}, {0x2c04010, ...})
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1122 +0x3f7
github.com/rclone/rclone/fs/sync.(*syncCopyMove).SrcOnly(0x2c3dc3a12008, {0x2bfb100, 0x2c3dc3cdc060})
	/home/rclone/go/src/github.com/rclone/rclone/fs/sync/sync.go:1262 +0x1d7
github.com/rclone/rclone/fs/march.(*March).processJob.func7({0x2bfb100, 0x2c3dc3cdc060})
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:498 +0x56
github.com/rclone/rclone/fs/march.(*March).matchListings(0x2c3dc34494d0, 0x2c3dc36aad20, 0x2c3dc36aad90, 0x2c3dc3a97dd0, 0x2c3dc3a97d80, 0x2c3dc3a97d30)
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:369 +0x565
github.com/rclone/rclone/fs/march.(*March).processJob(0x2c3dc34494d0, {{0x0, 0x0}, {0x0, 0x0}, 0x7ffffffe, 0x7ffffffe, 0x0, 0x0})
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:497 +0x5ae
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:217 +0x18e
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 425 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 426 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 427 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 428 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 429 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 430 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 431 [select, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func1()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:210 +0xf8
sync.(*WaitGroup).Go.func1()
	/usr/local/go/src/sync/waitgroup.go:258 +0x4a
created by sync.(*WaitGroup).Go in goroutine 29
	/usr/local/go/src/sync/waitgroup.go:238 +0x73

goroutine 432 [chan receive, 9 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2()
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:259 +0x3c
created by github.com/rclone/rclone/fs/march.(*March).Run in goroutine 29
	/home/rclone/go/src/github.com/rclone/rclone/fs/march/march.go:257 +0x359

goroutine 440 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0x2c3dc32ae800)
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:222 +0xec
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 423
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:120 +0x43f

goroutine 441 [select]:
github.com/rclone/rclone/fs/accounting.(*Account).averageLoop(0x2c3dc32aef00)
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:222 +0xec
created by github.com/rclone/rclone/fs/accounting.newAccountSizeName in goroutine 422
	/home/rclone/go/src/github.com/rclone/rclone/fs/accounting/accounting.go:120 +0x43f
"./bisync.test -test.v -test.timeout 1h0m0s -remote TestPcloud: -verbose" - Finished ERROR in 1h15m2.431931214s (try 1/5): exit status 2: Failed []