Add flag to exit immediately when --max-duration reached

Thanks! Any idea when v1.55 will be cut? I've been running to custom build since your last post and it would be good to move away from that and back to the stable builds :slight_smile:

1.55 should be out at the end of the month (March)

The issue has re-emerged. rclone is no longer exiting even when --max-duration session deadline is reached. I think this is a seperate bug from the one fixed earlier.

Two changes since my post ~19 days ago:

  • I just upgraded to v1.55.0 (I had been running v1.55.0-beta.5261.004fa1c5f.fix-context-deadline until now)
  • I added --gphotos-read-size to my rclone runs to start catching corruptions from previous runs.

The fact that the issue has re-emerged means either of the above two changes are at fault. Personally, I don't think upgrading to v1.55.0 is the cause. I think adding --gphotos-read-size is reaching parts of the code that wasn't reached before.

Here's the command that was run:
timeout -v -s QUIT --preserve-status -k 1m 121m rclone sync --gphotos-read-size --transfers=10 --max-duration=59m --retries 1 --timeout 1m --fast-list --gphotos-include-archived --gphotos-start-year=1900 --log-level INFO --log-file=REDACTED.txt gphotos:media/by-month media/by-month

Instead of exiting after 59m, rclone was killed by timeout after 121m so I got a backtrace:

2021/04/01 03:02:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     2h0m0.0s

timeout: sending signal QUIT to command ‘rclone’
SIGQUIT: quit
PC=0x474221 m=0 sigcode=0

goroutine 0 [idle]:
runtime.futex(0x2d2bd50, 0x80, 0x0, 0x0, 0x7ffc00000000, 0x7ffccfb2b918, 0x7ffccfaf5428, 0x2d2b380, 0x7ffccfaf5438, 0x40c3ff, ...)
	runtime/sys_linux_amd64.s:579 +0x21
runtime.futexsleep(0x2d2bd50, 0x0, 0xffffffffffffffff)
	runtime/os_linux.go:44 +0x46
runtime.notesleep(0x2d2bd50)
	runtime/lock_futex.go:159 +0x9f
runtime.mPark()
	runtime/proc.go:1340 +0x39
runtime.stopm()
	runtime/proc.go:2257 +0x92
runtime.findrunnable(0xc000053000, 0x0)
	runtime/proc.go:2916 +0x72e
runtime.schedule()
	runtime/proc.go:3125 +0x2d7
runtime.park_m(0xc000001080)
	runtime/proc.go:3274 +0x9d
runtime.mcall(0x0)
	runtime/asm_amd64.s:327 +0x5b

goroutine 1 [semacquire, 120 minutes]:
sync.runtime_Semacquire(0xc0004d4d28)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc0004d4d20)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).Run(0xc0002ab5f0, 0x213dd20, 0xc0003e7380, 0xc0004b2fa0, 0xc0004b2f00)
	github.com/rclone/rclone/fs/march/march.go:210 +0x397
github.com/rclone/rclone/fs/sync.(*syncCopyMove).run(0xc000507600, 0xc000128000, 0x21536e8)
	github.com/rclone/rclone/fs/sync/sync.go:843 +0x225
github.com/rclone/rclone/fs/sync.runSyncCopyMove(0x213dce8, 0xc000128000, 0x21536e8, 0xc0002ab4d0, 0x2153218, 0xc0004b2fa0, 0xc000000003, 0xc000635ad8, 0x2d2bc00)
	github.com/rclone/rclone/fs/sync/sync.go:1078 +0x299
github.com/rclone/rclone/fs/sync.Sync(0x213dce8, 0xc000128000, 0x21536e8, 0xc0002ab4d0, 0x2153218, 0xc0004b2fa0, 0x1733200, 0x1bb7d20, 0xc00059a828)
	github.com/rclone/rclone/fs/sync/sync.go:1084 +0x9c
github.com/rclone/rclone/cmd/sync.glob..func1.1(0xc00059a828, 0xc000128000)
	github.com/rclone/rclone/cmd/sync/sync.go:60 +0x79
github.com/rclone/rclone/cmd.Run(0xc0001f0101, 0x2d18980, 0xc000923d30)
	github.com/rclone/rclone/cmd/cmd.go:256 +0xed
github.com/rclone/rclone/cmd/sync.glob..func1(0x2d18980, 0xc0001fe690, 0x2, 0xf)
	github.com/rclone/rclone/cmd/sync/sync.go:58 +0x12a
github.com/spf13/cobra.(*Command).execute(0x2d18980, 0xc0001fe5a0, 0xf, 0xf, 0x2d18980, 0xc0001fe5a0)
	github.com/spf13/cobra@v1.1.1/command.go:854 +0x2c2
github.com/spf13/cobra.(*Command).ExecuteC(0x2d0cf20, 0x0, 0x0, 0xc00005c778)
	github.com/spf13/cobra@v1.1.1/command.go:958 +0x375
github.com/spf13/cobra.(*Command).Execute(...)
	github.com/spf13/cobra@v1.1.1/command.go:895
github.com/rclone/rclone/cmd.Main()
	github.com/rclone/rclone/cmd/cmd.go:555 +0xad
main.main()
	github.com/rclone/rclone/rclone.go:14 +0x25

goroutine 20 [select, 2 minutes]:
go.opencensus.io/stats/view.(*worker).start(0xc000185380)
	go.opencensus.io@v0.22.6/stats/view/worker.go:276 +0xcd
created by go.opencensus.io/stats/view.init.0
	go.opencensus.io@v0.22.6/stats/view/worker.go:34 +0x68

goroutine 8 [select, 2 minutes]:
github.com/rclone/rclone/cmd.StartStats.func2(0xc0004d4cb0, 0xc000114f60)
	github.com/rclone/rclone/cmd/cmd.go:365 +0x10d
created by github.com/rclone/rclone/cmd.StartStats
	github.com/rclone/rclone/cmd/cmd.go:361 +0xb1

goroutine 59 [semacquire, 68 minutes]:
sync.runtime_Semacquire(0xc0093ed984)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc0093ed984)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).processJob(0xc0002ab5f0, 0xc0007a82f0, 0xc, 0xc0005a77d0, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0x0, 0x0, ...)
	github.com/rclone/rclone/fs/march/march.go:405 +0x129
github.com/rclone/rclone/fs/march.(*March).Run.func1(0xc0004d4d10, 0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d00, 0xc000299890, 0xc0004d4d08, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:163 +0x1d6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:153 +0x265

goroutine 60 [semacquire, 115 minutes]:
sync.runtime_Semacquire(0xc0007a92f8)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc0007a92f0)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).processJob(0xc0002ab5f0, 0xc000645440, 0xc, 0xc000b6e520, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0x0, 0x0, ...)
	github.com/rclone/rclone/fs/march/march.go:405 +0x129
github.com/rclone/rclone/fs/march.(*March).Run.func1(0xc0004d4d10, 0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d00, 0xc000299890, 0xc0004d4d08, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:163 +0x1d6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:153 +0x265

goroutine 61 [semacquire, 116 minutes]:
sync.runtime_Semacquire(0xc00049aec8)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc00049aec0)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).processJob(0xc0002ab5f0, 0xc000a1d820, 0xc, 0xc000a1d730, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0x0, 0x0, ...)
	github.com/rclone/rclone/fs/march/march.go:405 +0x129
github.com/rclone/rclone/fs/march.(*March).Run.func1(0xc0004d4d10, 0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d00, 0xc000299890, 0xc0004d4d08, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:163 +0x1d6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:153 +0x265

goroutine 62 [semacquire, 96 minutes]:
sync.runtime_Semacquire(0xc00902f9c8)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc00902f9c0)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).processJob(0xc0002ab5f0, 0xc0032dccd0, 0xc, 0xc00246d3c0, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0x0, 0x0, ...)
	github.com/rclone/rclone/fs/march/march.go:405 +0x129
github.com/rclone/rclone/fs/march.(*March).Run.func1(0xc0004d4d10, 0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d00, 0xc000299890, 0xc0004d4d08, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:163 +0x1d6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:153 +0x265

goroutine 63 [semacquire, 84 minutes]:
sync.runtime_Semacquire(0xc009767368)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc009767360)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).processJob(0xc0002ab5f0, 0xc000a1d850, 0xc, 0xc000a1d640, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0x0, 0x0, ...)
	github.com/rclone/rclone/fs/march/march.go:405 +0x129
github.com/rclone/rclone/fs/march.(*March).Run.func1(0xc0004d4d10, 0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d00, 0xc000299890, 0xc0004d4d08, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:163 +0x1d6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:153 +0x265

goroutine 65 [semacquire, 116 minutes]:
sync.runtime_Semacquire(0xc000645a88)
	runtime/sema.go:56 +0x45
sync.(*WaitGroup).Wait(0xc000645a80)
	sync/waitgroup.go:130 +0x65
github.com/rclone/rclone/fs/march.(*March).processJob(0xc0002ab5f0, 0xc000b6f8b0, 0xc, 0xc00084d7e0, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0x0, 0x0, ...)
	github.com/rclone/rclone/fs/march/march.go:405 +0x129
github.com/rclone/rclone/fs/march.(*March).Run.func1(0xc0004d4d10, 0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d00, 0xc000299890, 0xc0004d4d08, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:163 +0x1d6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:153 +0x265

goroutine 67 [chan receive, 61 minutes]:
github.com/rclone/rclone/fs/march.(*March).Run.func2(0xc0002ab5f0, 0xc0003e73e0, 0xc0004d4d20)
	github.com/rclone/rclone/fs/march/march.go:206 +0xb6
created by github.com/rclone/rclone/fs/march.(*March).Run
	github.com/rclone/rclone/fs/march/march.go:203 +0x386

goroutine 5594 [chan receive, 2 minutes]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0003e7140)
	github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x3c
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0003e7140, 0xc000596980, 0xa, 0x38, 0x1c96520)
	github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x65
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0003e7140, 0xc000596980, 0x6, 0x1dcb900)
	github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x6a
github.com/rclone/rclone/backend/googlephotos.(*Object).Size(0xc0046aa9a0, 0x0)
	github.com/rclone/rclone/backend/googlephotos/googlephotos.go:814 +0x456
github.com/rclone/rclone/fs/filter.(*Filter).IncludeObject(0xc000102600, 0x213dcb0, 0xc00041dac0, 0x2153288, 0xc0046aa9a0, 0x2153288)
	github.com/rclone/rclone/fs/filter/filter.go:485 +0x134
github.com/rclone/rclone/fs/list.filterAndSortDir(0x213dcb0, 0xc00041dac0, 0xc0060a0000, 0x4a4f, 0x4c00, 0xc0002fcb00, 0xc000a1d820, 0xc, 0xc000d1be98, 0xc0002fcba0, ...)
	github.com/rclone/rclone/fs/list/list.go:54 +0x685
github.com/rclone/rclone/fs/list.DirSorted(0x213dcb0, 0xc00041dac0, 0x2153218, 0xc0004b2fa0, 0x748400, 0xc000a1d820, 0xc, 0x1af4cc0, 0x1ae2800, 0x7f61508c0dd0, ...)
	github.com/rclone/rclone/fs/list/list.go:36 +0x1dc
github.com/rclone/rclone/fs/march.(*March).makeListDir.func1(0xc000a1d820, 0xc, 0x1af4cc0, 0x1ae2800, 0xc00098f600, 0x7f61508c0dd0, 0xc000cad7d0)
	github.com/rclone/rclone/fs/march/march.go:85 +0x68
github.com/rclone/rclone/fs/march.(*March).processJob.func1(0xc00049aec0, 0xc0002ab5f0, 0xc000a1d820, 0xc, 0xc000a1d730, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0xc000b57a40, ...)
	github.com/rclone/rclone/fs/march/march.go:393 +0x6a
created by github.com/rclone/rclone/fs/march.(*March).processJob
	github.com/rclone/rclone/fs/march/march.go:391 +0x1265

goroutine 83483 [IO wait, 2 minutes]:
internal/poll.runtime_pollWait(0x7f6150d370f0, 0x72, 0xffffffffffffffff)
	runtime/netpoll.go:222 +0x55
internal/poll.(*pollDesc).wait(0xc000184918, 0x72, 0xf00, 0xfd7, 0xffffffffffffffff)
	internal/poll/fd_poll_runtime.go:87 +0x45
internal/poll.(*pollDesc).waitRead(...)
	internal/poll/fd_poll_runtime.go:92
internal/poll.(*FD).Read(0xc000184900, 0xc0005e4000, 0xfd7, 0xfd7, 0x0, 0x0, 0x0)
	internal/poll/fd_unix.go:166 +0x1d5
net.(*netFD).Read(0xc000184900, 0xc0005e4000, 0xfd7, 0xfd7, 0xc0005e4005, 0xc00085e518, 0xc0006a67c0)
	net/fd_posix.go:55 +0x4f
net.(*conn).Read(0xc0006ce2a8, 0xc0005e4000, 0xfd7, 0xfd7, 0x0, 0x0, 0x0)
	net/net.go:183 +0x91
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc0006ac138, 0xc0005e4000, 0xfd7, 0xfd7, 0x40db9b, 0xc00042c210, 0x18)
	github.com/rclone/rclone/fs/fshttp/dialer.go:98 +0x58
crypto/tls.(*atLeastReader).Read(0xc00042c210, 0xc0005e4000, 0xfd7, 0xfd7, 0xc0006a6801, 0xc000100000, 0x0)
	crypto/tls/conn.go:776 +0x63
bytes.(*Buffer).ReadFrom(0xc0000e5078, 0x210a940, 0xc00042c210, 0x40b925, 0x1af4d40, 0x1c6f9a0)
	bytes/buffer.go:204 +0xbe
crypto/tls.(*Conn).readFromUntil(0xc0000e4e00, 0x7f61508a6128, 0xc0006ac138, 0x5, 0xc0006ac138, 0x2d2ab00)
	crypto/tls/conn.go:798 +0xf3
crypto/tls.(*Conn).readRecordOrCCS(0xc0000e4e00, 0x0, 0x0, 0x0)
	crypto/tls/conn.go:605 +0x115
crypto/tls.(*Conn).readRecord(...)
	crypto/tls/conn.go:573
crypto/tls.(*Conn).Read(0xc0000e4e00, 0xc00075c000, 0x1000, 0x1000, 0x0, 0x0, 0x0)
	crypto/tls/conn.go:1276 +0x165
bufio.(*Reader).Read(0xc0062346c0, 0xc00977c1f8, 0x9, 0x9, 0x11, 0x0, 0x0)
	bufio/bufio.go:227 +0x222
io.ReadAtLeast(0x210a6c0, 0xc0062346c0, 0xc00977c1f8, 0x9, 0x9, 0x9, 0xc0006a6d08, 0x59939b, 0xc0006acca8)
	io/io.go:328 +0x87
io.ReadFull(...)
	io/io.go:347
net/http.http2readFrameHeader(0xc00977c1f8, 0x9, 0x9, 0x210a6c0, 0xc0062346c0, 0x0, 0x0, 0xc000758468, 0x0)
	net/http/h2_bundle.go:1477 +0x89
net/http.(*http2Framer).ReadFrame(0xc00977c1c0, 0xc00927a048, 0x0, 0x0, 0x0)
	net/http/h2_bundle.go:1735 +0xa5
net/http.(*http2clientConnReadLoop).run(0xc0006a6fa8, 0x0, 0x0)
	net/http/h2_bundle.go:8322 +0xd8
net/http.(*http2ClientConn).readLoop(0xc000758300)
	net/http/h2_bundle.go:8244 +0x6f
created by net/http.(*http2Transport).newClientConn
	net/http/h2_bundle.go:7208 +0x6c5

goroutine 83471 [sleep]:
time.Sleep(0x3db41fbda)
	runtime/time.go:193 +0xd2
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall.func1(0xc0003e7140, 0x3db41fbda)
	github.com/rclone/rclone/lib/pacer/pacer.go:167 +0x2b
created by github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall
	github.com/rclone/rclone/lib/pacer/pacer.go:166 +0x90

goroutine 5392 [chan receive, 2 minutes]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0003e7140)
	github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x3c
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0003e7140, 0xc000140300, 0xa, 0x38, 0x1c96520)
	github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x65
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0003e7140, 0xc000140300, 0x6, 0x1dcb900)
	github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x6a
github.com/rclone/rclone/backend/googlephotos.(*Object).Size(0xc005d6b5e0, 0x0)
	github.com/rclone/rclone/backend/googlephotos/googlephotos.go:814 +0x456
github.com/rclone/rclone/fs/filter.(*Filter).IncludeObject(0xc000102600, 0x213dcb0, 0xc00041dac0, 0x2153288, 0xc005d6b5e0, 0x2153288)
	github.com/rclone/rclone/fs/filter/filter.go:485 +0x134
github.com/rclone/rclone/fs/list.filterAndSortDir(0x213dcb0, 0xc00041dac0, 0xc002980000, 0x22e3, 0x2600, 0xc00569e600, 0xc000b6f8b0, 0xc, 0xc001303e98, 0xc00569e660, ...)
	github.com/rclone/rclone/fs/list/list.go:54 +0x685
github.com/rclone/rclone/fs/list.DirSorted(0x213dcb0, 0xc00041dac0, 0x2153218, 0xc0004b2fa0, 0x466a00, 0xc000b6f8b0, 0xc, 0x1af4cc0, 0x1ae2800, 0x7f61508c0dd0, ...)
	github.com/rclone/rclone/fs/list/list.go:36 +0x1dc
github.com/rclone/rclone/fs/march.(*March).makeListDir.func1(0xc000b6f8b0, 0xc, 0x1af4cc0, 0x1ae2800, 0x0, 0x7f61508c0dd0, 0xc000741fd0)
	github.com/rclone/rclone/fs/march/march.go:85 +0x68
github.com/rclone/rclone/fs/march.(*March).processJob.func1(0xc000645a80, 0xc0002ab5f0, 0xc000b6f8b0, 0xc, 0xc00084d7e0, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0xc000b56bb8, ...)
	github.com/rclone/rclone/fs/march/march.go:393 +0x6a
created by github.com/rclone/rclone/fs/march.(*March).processJob
	github.com/rclone/rclone/fs/march/march.go:391 +0x1265

goroutine 5859 [chan receive, 2 minutes]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0003e7140)
	github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x3c
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0003e7140, 0xc0006f2180, 0xa, 0x38, 0x1c96520)
	github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x65
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0003e7140, 0xc0006f2180, 0x6, 0x1dcb900)
	github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x6a
github.com/rclone/rclone/backend/googlephotos.(*Object).Size(0xc00416ef50, 0x0)
	github.com/rclone/rclone/backend/googlephotos/googlephotos.go:814 +0x456
github.com/rclone/rclone/fs/filter.(*Filter).IncludeObject(0xc000102600, 0x213dcb0, 0xc00041dac0, 0x2153288, 0xc00416ef50, 0x2153288)
	github.com/rclone/rclone/fs/filter/filter.go:485 +0x134
github.com/rclone/rclone/fs/list.filterAndSortDir(0x213dcb0, 0xc00041dac0, 0xc0071fe000, 0x529b, 0x6000, 0xc008306300, 0xc000645440, 0xc, 0xc00091de98, 0xc008306300, ...)
	github.com/rclone/rclone/fs/list/list.go:54 +0x685
github.com/rclone/rclone/fs/list.DirSorted(0x213dcb0, 0xc00041dac0, 0x2153218, 0xc0004b2fa0, 0x748400, 0xc000645440, 0xc, 0x1af4cc0, 0x1ae2800, 0x7f61508c0dd0, ...)
	github.com/rclone/rclone/fs/list/list.go:36 +0x1dc
github.com/rclone/rclone/fs/march.(*March).makeListDir.func1(0xc000645440, 0xc, 0x1af4cc0, 0x1ae2800, 0xc000b80a00, 0x7f61508c0dd0, 0xc00069e7d0)
	github.com/rclone/rclone/fs/march/march.go:85 +0x68
github.com/rclone/rclone/fs/march.(*March).processJob.func1(0xc0007a92f0, 0xc0002ab5f0, 0xc000645440, 0xc, 0xc000b6e520, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0xc0006d2270, ...)
	github.com/rclone/rclone/fs/march/march.go:393 +0x6a
created by github.com/rclone/rclone/fs/march.(*March).processJob
	github.com/rclone/rclone/fs/march/march.go:391 +0x1265

goroutine 23451 [chan receive, 2 minutes]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0003e7140)
	github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x3c
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0003e7140, 0xc0006f2340, 0xa, 0x38, 0x1c96520)
	github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x65
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0003e7140, 0xc0006f2340, 0x6, 0x1dcb900)
	github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x6a
github.com/rclone/rclone/backend/googlephotos.(*Object).Size(0xc003845b20, 0x0)
	github.com/rclone/rclone/backend/googlephotos/googlephotos.go:814 +0x456
github.com/rclone/rclone/fs/filter.(*Filter).IncludeObject(0xc000102600, 0x213dcb0, 0xc00041dac0, 0x2153288, 0xc003845b20, 0x2153288)
	github.com/rclone/rclone/fs/filter/filter.go:485 +0x134
github.com/rclone/rclone/fs/list.filterAndSortDir(0x213dcb0, 0xc00041dac0, 0xc008a88000, 0x1803, 0x1e00, 0xc0089da000, 0xc0032dccd0, 0xc, 0xc000613e98, 0xc0089da060, ...)
	github.com/rclone/rclone/fs/list/list.go:54 +0x685
github.com/rclone/rclone/fs/list.DirSorted(0x213dcb0, 0xc00041dac0, 0x2153218, 0xc0004b2fa0, 0x748400, 0xc0032dccd0, 0xc, 0xc000114ef8, 0xc000114eb0, 0xc0070f6fc0, ...)
	github.com/rclone/rclone/fs/list/list.go:36 +0x1dc
github.com/rclone/rclone/fs/march.(*March).makeListDir.func1(0xc0032dccd0, 0xc, 0x40e2f8, 0x48, 0x43b205, 0x1eae608, 0x0)
	github.com/rclone/rclone/fs/march/march.go:85 +0x68
github.com/rclone/rclone/fs/march.(*March).processJob.func1(0xc00902f9c0, 0xc0002ab5f0, 0xc0032dccd0, 0xc, 0xc00246d3c0, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0xc00063c408, ...)
	github.com/rclone/rclone/fs/march/march.go:393 +0x6a
created by github.com/rclone/rclone/fs/march.(*March).processJob
	github.com/rclone/rclone/fs/march/march.go:391 +0x1265

goroutine 82568 [IO wait]:
internal/poll.runtime_pollWait(0x7f6150d37578, 0x72, 0xffffffffffffffff)
	runtime/netpoll.go:222 +0x55
internal/poll.(*pollDesc).wait(0xc0006ba798, 0x72, 0x1800, 0x18db, 0xffffffffffffffff)
	internal/poll/fd_poll_runtime.go:87 +0x45
internal/poll.(*pollDesc).waitRead(...)
	internal/poll/fd_poll_runtime.go:92
internal/poll.(*FD).Read(0xc0006ba780, 0xc000a62000, 0x18db, 0x18db, 0x0, 0x0, 0x0)
	internal/poll/fd_unix.go:166 +0x1d5
net.(*netFD).Read(0xc0006ba780, 0xc000a62000, 0x18db, 0x18db, 0x7f6150d50c00, 0x0, 0x418dd3)
	net/fd_posix.go:55 +0x4f
net.(*conn).Read(0xc0006ce218, 0xc000a62000, 0x18db, 0x18db, 0x0, 0x0, 0x0)
	net/net.go:183 +0x91
github.com/rclone/rclone/fs/fshttp.(*timeoutConn).Read(0xc00059a300, 0xc000a62000, 0x18db, 0x18db, 0x40db9b, 0xc00042c018, 0x18)
	github.com/rclone/rclone/fs/fshttp/dialer.go:98 +0x58
crypto/tls.(*atLeastReader).Read(0xc00042c018, 0xc000a62000, 0x18db, 0x18db, 0xc0006a4801, 0xc0006c0000, 0x0)
	crypto/tls/conn.go:776 +0x63
bytes.(*Buffer).ReadFrom(0xc0008b8278, 0x210a940, 0xc00042c018, 0x40b925, 0x1af4d40, 0x1c6f9a0)
	bytes/buffer.go:204 +0xbe
crypto/tls.(*Conn).readFromUntil(0xc0008b8000, 0x7f61508a6128, 0xc00059a300, 0x5, 0xc00059a300, 0x2d2ab00)
	crypto/tls/conn.go:798 +0xf3
crypto/tls.(*Conn).readRecordOrCCS(0xc0008b8000, 0x0, 0x0, 0x0)
	crypto/tls/conn.go:605 +0x115
crypto/tls.(*Conn).readRecord(...)
	crypto/tls/conn.go:573
crypto/tls.(*Conn).Read(0xc0008b8000, 0xc000639000, 0x1000, 0x1000, 0x0, 0x0, 0x0)
	crypto/tls/conn.go:1276 +0x165
bufio.(*Reader).Read(0xc006234240, 0xc00977c2d8, 0x9, 0x9, 0x11, 0x0, 0x0)
	bufio/bufio.go:227 +0x222
io.ReadAtLeast(0x210a6c0, 0xc006234240, 0xc00977c2d8, 0x9, 0x9, 0x9, 0xc0006a4d08, 0x59939b, 0xc008802d20)
	io/io.go:328 +0x87
io.ReadFull(...)
	io/io.go:347
net/http.http2readFrameHeader(0xc00977c2d8, 0x9, 0x9, 0x210a6c0, 0xc006234240, 0x0, 0x0, 0xc000758168, 0x0)
	net/http/h2_bundle.go:1477 +0x89
net/http.(*http2Framer).ReadFrame(0xc00977c2a0, 0xc00927a078, 0x0, 0x0, 0x0)
	net/http/h2_bundle.go:1735 +0xa5
net/http.(*http2clientConnReadLoop).run(0xc0006a4fa8, 0x0, 0x0)
	net/http/h2_bundle.go:8322 +0xd8
net/http.(*http2ClientConn).readLoop(0xc000758000)
	net/http/h2_bundle.go:8244 +0x6f
created by net/http.(*http2Transport).newClientConn
	net/http/h2_bundle.go:7208 +0x6c5

goroutine 35183 [chan receive, 2 minutes]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0003e7140)
	github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x3c
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0003e7140, 0xc000596740, 0xa, 0x38, 0x1c96520)
	github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x65
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0003e7140, 0xc000596740, 0x6, 0x1dcb900)
	github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x6a
github.com/rclone/rclone/backend/googlephotos.(*Object).Size(0xc003eaa770, 0x0)
	github.com/rclone/rclone/backend/googlephotos/googlephotos.go:814 +0x456
github.com/rclone/rclone/fs/filter.(*Filter).IncludeObject(0xc000102600, 0x213dcb0, 0xc00041dac0, 0x2153288, 0xc003eaa770, 0x2153288)
	github.com/rclone/rclone/fs/filter/filter.go:485 +0x134
github.com/rclone/rclone/fs/list.filterAndSortDir(0x213dcb0, 0xc00041dac0, 0xc009e5e000, 0x1178, 0x1200, 0xc003982800, 0xc000a1d850, 0xc, 0xc00070fe98, 0xc003982870, ...)
	github.com/rclone/rclone/fs/list/list.go:54 +0x685
github.com/rclone/rclone/fs/list.DirSorted(0x213dcb0, 0xc00041dac0, 0x2153218, 0xc0004b2fa0, 0xc0006c2400, 0xc000a1d850, 0xc, 0xc000114ef8, 0xc000114eb0, 0xc000b7b7c0, ...)
	github.com/rclone/rclone/fs/list/list.go:36 +0x1dc
github.com/rclone/rclone/fs/march.(*March).makeListDir.func1(0xc000a1d850, 0xc, 0x40e2f8, 0x48, 0x43b205, 0x1eae608, 0x0)
	github.com/rclone/rclone/fs/march/march.go:85 +0x68
github.com/rclone/rclone/fs/march.(*March).processJob.func1(0xc009767360, 0xc0002ab5f0, 0xc000a1d850, 0xc, 0xc000a1d640, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0xc0005d13b0, ...)
	github.com/rclone/rclone/fs/march/march.go:393 +0x6a
created by github.com/rclone/rclone/fs/march.(*March).processJob
	github.com/rclone/rclone/fs/march/march.go:391 +0x1265

goroutine 79731 [chan receive]:
github.com/rclone/rclone/lib/pacer.(*Pacer).beginCall(0xc0003e7140)
	github.com/rclone/rclone/lib/pacer/pacer.go:159 +0x3c
github.com/rclone/rclone/lib/pacer.(*Pacer).call(0xc0003e7140, 0xc0006f2240, 0xa, 0x38, 0x1c96520)
	github.com/rclone/rclone/lib/pacer/pacer.go:196 +0x65
github.com/rclone/rclone/lib/pacer.(*Pacer).Call(0xc0003e7140, 0xc0006f2240, 0x6, 0x1dcb900)
	github.com/rclone/rclone/lib/pacer/pacer.go:216 +0x6a
github.com/rclone/rclone/backend/googlephotos.(*Object).Size(0xc003071420, 0x0)
	github.com/rclone/rclone/backend/googlephotos/googlephotos.go:814 +0x456
github.com/rclone/rclone/fs/filter.(*Filter).IncludeObject(0xc000102600, 0x213dcb0, 0xc00041dac0, 0x2153288, 0xc003071420, 0x2153288)
	github.com/rclone/rclone/fs/filter/filter.go:485 +0x134
github.com/rclone/rclone/fs/list.filterAndSortDir(0x213dcb0, 0xc00041dac0, 0xc00968e000, 0x2ea, 0x400, 0xc00a1d4100, 0xc0007a82f0, 0xc, 0xc000847e98, 0xc00a1d41e0, ...)
	github.com/rclone/rclone/fs/list/list.go:54 +0x685
github.com/rclone/rclone/fs/list.DirSorted(0x213dcb0, 0xc00041dac0, 0x2153218, 0xc0004b2fa0, 0xc00084ec00, 0xc0007a82f0, 0xc, 0xc000114ef8, 0xc000114eb0, 0xc0009017c0, ...)
	github.com/rclone/rclone/fs/list/list.go:36 +0x1dc
github.com/rclone/rclone/fs/march.(*March).makeListDir.func1(0xc0007a82f0, 0xc, 0x40e2f8, 0x48, 0x43b205, 0x1eae608, 0x0)
	github.com/rclone/rclone/fs/march/march.go:85 +0x68
github.com/rclone/rclone/fs/march.(*March).processJob.func1(0xc0093ed984, 0xc0002ab5f0, 0xc0007a82f0, 0xc, 0xc0005a77d0, 0xc, 0x7ffffffc, 0x7ffffffc, 0x0, 0xc007da1d70, ...)
	github.com/rclone/rclone/fs/march/march.go:393 +0x6a
created by github.com/rclone/rclone/fs/march.(*March).processJob
	github.com/rclone/rclone/fs/march/march.go:391 +0x1265

rax    0xca
rbx    0x2d2bc00
rcx    0x474223
rdx    0x0
rdi    0x2d2bd50
rsi    0x80
rbp    0x7ffccfaf5400
rsp    0x7ffccfaf53b8
r8     0x0
r9     0x0
r10    0x0
r11    0x286
r12    0x0
r13    0x189
r14    0x2c76500
r15    0x2030000
rip    0x474221
rflags 0x286
cs     0x33
fs     0x0
gs     0x0

Here's the rest of log file (excluding backtrace already pasted above) - not much happens after the 58m mark:

2021/04/01 01:02:02 INFO  : Local file system at /REDACTED/media/by-month: Transfer session deadline: 2021/04/01 02:01:02
2021/04/01 01:03:02 INFO  : 
Transferred:   	         0 / 0 Bytes, -, 0 Bytes/s, ETA -
Elapsed time:       1m0.0s

2021/04/01 01:04:02 INFO  : 
Transferred:   	         0 / 0 Bytes, -, 0 Bytes/s, ETA -
Elapsed time:       2m0.0s

2021/04/01 01:05:02 INFO  : 
Transferred:   	         0 / 0 Bytes, -, 0 Bytes/s, ETA -
Elapsed time:       3m0.0s

2021/04/01 01:06:02 INFO  : 
Transferred:   	         0 / 0 Bytes, -, 0 Bytes/s, ETA -
Elapsed time:       4m0.0s

2021/04/01 01:06:44 INFO  : 2008/2008-01/chand room1 001_Resized.jpg: Copied (replaced existing)
2021/04/01 01:06:45 INFO  : 2008/2008-01/chand room1 003_Resize.jpg: Copied (replaced existing)
2021/04/01 01:06:45 INFO  : 2008/2008-01/chand room1 011_Resize.jpg: Copied (replaced existing)
2021/04/01 01:07:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.140 MBytes/s, ETA 0s
Checks:                54 / 54, 100%
Transferred:            3 / 3, 100%
Elapsed time:       5m0.0s

2021/04/01 01:08:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.122 MBytes/s, ETA 0s
Checks:               330 / 330, 100%
Transferred:            3 / 3, 100%
Elapsed time:       6m0.0s

2021/04/01 01:09:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.122 MBytes/s, ETA 0s
Checks:               330 / 330, 100%
Transferred:            3 / 3, 100%
Elapsed time:       7m0.0s

2021/04/01 01:10:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.103 MBytes/s, ETA 0s
Checks:               679 / 679, 100%
Transferred:            3 / 3, 100%
Elapsed time:       8m0.0s

2021/04/01 01:11:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.076 MBytes/s, ETA 0s
Checks:              1061 / 1061, 100%
Transferred:            3 / 3, 100%
Elapsed time:       9m0.0s

2021/04/01 01:12:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      10m0.0s

2021/04/01 01:13:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      11m0.0s

2021/04/01 01:14:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      12m0.0s

2021/04/01 01:15:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      13m0.0s

2021/04/01 01:16:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      14m0.0s

2021/04/01 01:17:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      15m0.0s

2021/04/01 01:18:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      16m0.0s

2021/04/01 01:19:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.047 MBytes/s, ETA 0s
Checks:              1585 / 1585, 100%
Transferred:            3 / 3, 100%
Elapsed time:      17m0.0s

2021/04/01 01:20:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.016 MBytes/s, ETA 0s
Checks:              2500 / 2500, 100%
Transferred:            3 / 3, 100%
Elapsed time:      18m0.0s

2021/04/01 01:21:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.009 MBytes/s, ETA 0s
Checks:              2602 / 2602, 100%
Transferred:            3 / 3, 100%
Elapsed time:      19m0.0s

2021/04/01 01:22:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.009 MBytes/s, ETA 0s
Checks:              2602 / 2602, 100%
Transferred:            3 / 3, 100%
Elapsed time:      20m0.0s

2021/04/01 01:23:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.995 MBytes/s, ETA 0s
Checks:              2802 / 2802, 100%
Transferred:            3 / 3, 100%
Elapsed time:      21m0.0s

2021/04/01 01:24:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.995 MBytes/s, ETA 0s
Checks:              2802 / 2802, 100%
Transferred:            3 / 3, 100%
Elapsed time:      22m0.0s

2021/04/01 01:25:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.995 MBytes/s, ETA 0s
Checks:              2802 / 2802, 100%
Transferred:            3 / 3, 100%
Elapsed time:      23m0.0s

2021/04/01 01:26:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.995 MBytes/s, ETA 0s
Checks:              2802 / 2802, 100%
Transferred:            3 / 3, 100%
Elapsed time:      24m0.0s

2021/04/01 01:27:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.973 MBytes/s, ETA 0s
Checks:              3190 / 3190, 100%
Transferred:            3 / 3, 100%
Elapsed time:      25m0.0s

2021/04/01 01:28:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.940 MBytes/s, ETA 0s
Checks:              5016 / 5016, 100%
Transferred:            3 / 3, 100%
Elapsed time:      26m0.0s

2021/04/01 01:29:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.926 MBytes/s, ETA 0s
Checks:              5251 / 5251, 100%
Transferred:            3 / 3, 100%
Elapsed time:      27m0.0s

2021/04/01 01:30:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.926 MBytes/s, ETA 0s
Checks:              5251 / 5251, 100%
Transferred:            3 / 3, 100%
Elapsed time:      28m0.0s

2021/04/01 01:31:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.926 MBytes/s, ETA 0s
Checks:              5251 / 5251, 100%
Transferred:            3 / 3, 100%
Elapsed time:      29m0.0s

2021/04/01 01:32:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.926 MBytes/s, ETA 0s
Checks:              5251 / 5251, 100%
Transferred:            3 / 3, 100%
Elapsed time:      30m0.0s

2021/04/01 01:33:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.926 MBytes/s, ETA 0s
Checks:              5251 / 5251, 100%
Transferred:            3 / 3, 100%
Elapsed time:      31m0.0s

2021/04/01 01:34:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.894 MBytes/s, ETA 0s
Checks:              5865 / 5865, 100%
Transferred:            3 / 3, 100%
Elapsed time:      32m0.0s

2021/04/01 01:35:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.884 MBytes/s, ETA 0s
Checks:              5952 / 5952, 100%
Transferred:            3 / 3, 100%
Elapsed time:      33m0.0s

2021/04/01 01:36:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.884 MBytes/s, ETA 0s
Checks:              5952 / 5952, 100%
Transferred:            3 / 3, 100%
Elapsed time:      34m0.0s

2021/04/01 01:37:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.884 MBytes/s, ETA 0s
Checks:              5952 / 5952, 100%
Transferred:            3 / 3, 100%
Elapsed time:      35m0.0s

2021/04/01 01:38:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.884 MBytes/s, ETA 0s
Checks:              5952 / 5952, 100%
Transferred:            3 / 3, 100%
Elapsed time:      36m0.0s

2021/04/01 01:39:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.884 MBytes/s, ETA 0s
Checks:              5952 / 5952, 100%
Transferred:            3 / 3, 100%
Elapsed time:      37m0.0s

2021/04/01 01:40:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      38m0.0s

2021/04/01 01:41:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      39m0.0s

2021/04/01 01:42:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      40m0.0s

2021/04/01 01:43:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      41m0.0s

2021/04/01 01:44:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      42m0.0s

2021/04/01 01:45:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      43m0.0s

2021/04/01 01:46:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      44m0.0s

2021/04/01 01:47:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      45m0.0s

2021/04/01 01:48:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      46m0.0s

2021/04/01 01:49:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.849 MBytes/s, ETA 0s
Checks:              6673 / 6673, 100%
Transferred:            3 / 3, 100%
Elapsed time:      47m0.0s

2021/04/01 01:50:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 33.553 kBytes/s, ETA 0s
Checks:              7120 / 7123, 100%
Transferred:            3 / 3, 100%
Elapsed time:      48m0.0s

2021/04/01 01:51:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 12.463 kBytes/s, ETA 0s
Checks:             11031 / 11345, 97%
Transferred:            3 / 3, 100%
Elapsed time:      49m0.0s
Checking:
 * 2009/2009-02/fb_DSC_03…J4uhgNcq0VNbtjpVA}.JPG: checking
 * 2009/2009-02/fb_DSC_03…3XbO57Kje3oZO74fQ}.JPG: checking

2021/04/01 01:52:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 6.847 kBytes/s, ETA 0s
Checks:             12439 / 12443, 100%
Transferred:            3 / 3, 100%
Elapsed time:      50m0.0s
Checking:
 *                  2009/2009-02/sr_DSC_0615.JPG: checking
 *                  2009/2009-02/sr_DSC_0616.JPG: checking

2021/04/01 01:53:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 5.141 kBytes/s, ETA 0s
Checks:             13175 / 13177, 100%
Transferred:            3 / 3, 100%
Elapsed time:      51m0.0s

2021/04/01 01:54:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.983 kBytes/s, ETA 0s
Checks:             14167 / 14171, 100%
Transferred:            3 / 3, 100%
Elapsed time:      52m0.0s
Checking:
 *                     2010/2010-02/DSC_4208.JPG: checking

2021/04/01 01:55:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 3.277 kBytes/s, ETA 0s
Checks:             15139 / 15143, 100%
Transferred:            3 / 3, 100%
Elapsed time:      53m0.0s
Checking:
 *                     2010/2010-02/DSC_5085.JPG: checking
 *                     2010/2010-02/DSC_5086.JPG: checking

2021/04/01 01:56:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.899 kBytes/s, ETA 0s
Checks:             19209 / 19211, 100%
Transferred:            3 / 3, 100%
Elapsed time:      54m0.0s

2021/04/01 01:57:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.739 kBytes/s, ETA 0s
Checks:             19389 / 19392, 100%
Transferred:            3 / 3, 100%
Elapsed time:      55m0.0s
Checking:
 *                     2011/2011-02/DSC_0225.JPG: checking

2021/04/01 01:58:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.451 kBytes/s, ETA 0s
Checks:             19391 / 19398, 100%
Transferred:            3 / 3, 100%
Elapsed time:      56m0.0s

2021/04/01 01:59:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 2.213 kBytes/s, ETA 0s
Checks:             19392 / 19399, 100%
Transferred:            3 / 3, 100%
Elapsed time:      57m0.0s
Checking:
 *                     2011/2011-02/DSC_0228.JPG: checking
 *                     2011/2011-02/DSC_0229.JPG: checking

2021/04/01 02:00:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.881 kBytes/s, ETA 0s
Checks:             19395 / 19399, 100%
Transferred:            3 / 3, 100%
Elapsed time:      58m0.0s
Checking:
 *                     2011/2011-02/DSC_0230.JPG: checking

2021/04/01 02:01:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.636 kBytes/s, ETA 0s
Checks:             19398 / 19401, 100%
Transferred:            3 / 3, 100%
Elapsed time:      59m0.0s
Checking:
 *                     2011/2011-02/DSC_0234.JPG: checking

2021/04/01 02:01:03 ERROR : 2013/2013-02: error reading source directory: couldn't list files: Post "https://photoslibrary.googleapis.com/v1/mediaItems:search": context deadline exceeded
2021/04/01 02:02:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.545 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19400 / 19401, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h0m0.0s

2021/04/01 02:03:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.387 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19400 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h1m0.0s
Checking:
 *                     2011/2011-02/DSC_0236.JPG: checking

2021/04/01 02:04:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h2m0.0s

2021/04/01 02:05:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h3m0.0s

2021/04/01 02:06:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h4m0.0s

2021/04/01 02:07:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h5m0.0s

2021/04/01 02:08:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h6m0.0s

2021/04/01 02:09:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h7m0.0s

2021/04/01 02:10:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h8m0.0s

2021/04/01 02:11:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     1h9m0.0s

2021/04/01 02:12:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h10m0.0s

2021/04/01 02:13:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h11m0.0s

2021/04/01 02:14:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h12m0.0s

2021/04/01 02:15:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h13m0.0s

2021/04/01 02:16:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h14m0.0s

2021/04/01 02:17:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h15m0.0s

2021/04/01 02:18:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h16m0.0s

2021/04/01 02:19:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h17m0.0s

2021/04/01 02:20:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h18m0.0s

2021/04/01 02:21:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h19m0.0s

2021/04/01 02:22:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h20m0.0s

2021/04/01 02:23:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h21m0.0s

2021/04/01 02:24:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h22m0.0s

2021/04/01 02:25:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h23m0.0s

2021/04/01 02:26:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h24m0.0s

2021/04/01 02:27:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h25m0.0s

2021/04/01 02:28:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h26m0.0s

2021/04/01 02:29:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h27m0.0s

2021/04/01 02:30:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h28m0.0s

2021/04/01 02:31:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h29m0.0s

2021/04/01 02:32:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h30m0.0s

2021/04/01 02:33:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h31m0.0s

2021/04/01 02:34:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h32m0.0s

2021/04/01 02:35:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h33m0.0s

2021/04/01 02:36:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h34m0.0s

2021/04/01 02:37:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h35m0.0s

2021/04/01 02:38:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h36m0.0s

2021/04/01 02:39:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h37m0.0s

2021/04/01 02:40:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h38m0.0s

2021/04/01 02:41:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h39m0.0s

2021/04/01 02:42:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h40m0.0s

2021/04/01 02:43:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h41m0.0s

2021/04/01 02:44:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h42m0.0s

2021/04/01 02:45:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h43m0.0s

2021/04/01 02:46:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h44m0.0s

2021/04/01 02:47:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h45m0.0s

2021/04/01 02:48:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h46m0.0s

2021/04/01 02:49:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h47m0.0s

2021/04/01 02:50:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h48m0.0s

2021/04/01 02:51:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h49m0.0s

2021/04/01 02:52:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h50m0.0s

2021/04/01 02:53:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h51m0.0s

2021/04/01 02:54:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h52m0.0s

2021/04/01 02:55:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h53m0.0s

2021/04/01 02:56:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h54m0.0s

2021/04/01 02:57:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h55m0.0s

2021/04/01 02:58:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h56m0.0s

2021/04/01 02:59:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h57m0.0s

2021/04/01 03:00:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h58m0.0s

2021/04/01 03:01:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:    1h59m0.0s

2021/04/01 03:02:02 INFO  : 
Transferred:   	  535.923k / 535.923 kBytes, 100%, 1.229 kBytes/s, ETA 0s
Errors:                 1 (retrying may help)
Checks:             19401 / 19402, 100%
Transferred:            3 / 3, 100%
Elapsed time:     2h0m0.0s

timeout: sending signal QUIT to command ‘rclone’
SIGQUIT: quit
PC=0x474221 m=0 sigcode=0

Yes, you are quite right that is exactly what is happening.

func (o *Object) Size() int64 {
	defer log.Trace(o, "")("")
	if !o.fs.opt.ReadSize || o.bytes >= 0 {
		return o.bytes
	}
	ctx := context.TODO()
	err := o.readMetaData(ctx)
	if err != nil {
		fs.Debugf(o, "Size: Failed to read metadata: %v", err)
		return -1
	}
	var resp *http.Response
	opts := rest.Opts{
		Method:  "HEAD",
		RootURL: o.downloadURL(),
	}
	err = o.fs.pacer.Call(func() (bool, error) {
		resp, err = o.fs.srv.Call(ctx, &opts)
		return shouldRetry(ctx, resp, err)
	})

Note the context.TODO that is because context isn't being passed into the Size call so we are just using a background context which won't be cancelled on --max-duration.

The proper way to fix this would be to change the interface to Size to pass the context in. This unfortunately is not a small change as it would involve changing all the backends and a lot of the sync code. It isn't a difficult change though.

That said, I'd encourage you not to use the --gphotos-read-size flag as it is really expensive in API hits - it is equivalent to 1 download every time it is called!

Thanks for a quick response as usual :slight_smile:

I see. As this doesn't cause any corruption I'm not bothered by it - timeout is making sure that rclone doesn't run forever. So for me personally this is very low impact & low priority issue.

Understood! As I've finally finished a full sync of my gphotos, I am using --gphotos-read-size as an easy way to be identify corrupt files. Since I have the workflow automated this seemed like the first easy option to go for - waiting days/weeks is not a problem for me since this all happens in the background anyway :slight_smile:

Once I have some time to spare (hopefully this easter weekend) I'll go through the rclone lsf options we discussed in Detecting incomplete file download from Google Photos - #4 by timevortex and then I can stop using --gphotos-read-size.

As usual, really appreciate your help and quick responses.

Glad I can help!

I agree with you that googlephotos Size method vs --max-duration is probably a minor problem and I'll ignore it for the moment.

This topic was automatically closed 60 days after the last reply. New replies are no longer allowed.