seedsync: Error parsing lftp job status

2020/06/08 24:41:05 - DEBUG - RemoteScanner - Running a scan
2020/06/08 24:41:05 - DEBUG - seedsync.Controller.Model - LftpModel: Updating file 'tv'
2020/06/08 24:41:05 - DEBUG - RemoteScanner.RemoteScanner.Sshcp - Command: ssh (redacted)
2020/06/08 24:41:06 - DEBUG - LocalScanner - Running a scan
2020/06/08 24:41:06 - DEBUG - LocalScanner - Scan took 0.056s
2020/06/08 24:41:06 - DEBUG - seedsync.Controller.Model - LftpModel: Updating file 'tv'
2020/06/08 24:41:07 - DEBUG - seedsync.Controller.Model - LftpModel: Updating file 'tv'
2020/06/08 24:41:08 - DEBUG - seedsync.Controller.Model - LftpModel: Updating file 'tv'
2020/06/08 24:41:08 - DEBUG - RemoteScanner.RemoteScanner.Sshcp - Return code: 0
2020/06/08 24:41:08 - DEBUG - RemoteScanner.RemoteScanner.Sshcp - Command took 2.365s
2020/06/08 24:41:08 - DEBUG - RemoteScanner - Scan took 2.366s
2020/06/08 24:41:08 - DEBUG - seedsync.Controller.Model - LftpModel: Updating file 'tv'
2020/06/08 24:41:09 - DEBUG - seedsync.Controller.Model - LftpModel: Updating file 'tv'
2020/06/08 24:41:10 - ERROR - seedsync.Controller.Lftp.LftpJobStatusParser - LftpJobStateParser error: Missing queue header line 1: 2020-06-08 05:41:10 sftp://(redacted).mkv -> /downloads/tv/(redacted).mkv.lftp 0-100812963 284.0 KiB/s
2020/06/08 24:41:10 - ERROR - seedsync.Controller.Lftp.LftpJobStatusParser - Status: 2020-06-08 05:41:10 sftp://(redacted).mkv -> /downloads/tv/(redacted).mkv.lftp 0-100812963 284.0 KiB/s [0] queue (sftp://(redacted)) -- 17.77 MiB/s sftp://(redacted) Now executing: [1] mirror -c /home/user/media/tv /downloads/ -- 30G/30G (97%) 17.77 MiB/s [1] mirror -c /home/user/media/tv /downloads/ -- 30G/30G (97%) 17.77 MiB/s \mirror `(redacted)' -- 19G/20G (96%) 17.77 MiB/s \mirror `(redacted)' \transfer `(redacted).mkv' `(redacted).mkv', got 1785656160 of 1790938502 (99%) 249.6K/s eta:20s \chunk 0-71637542 `(redacted).mkv' at 66355200 (3%) 249.6K/s eta:20s [Receiving data] \transfer `(redacted).mkv' `(redacted).mkv', got 1290108928 of 2057345443 (62%) 17.52M/s eta:3m \chunk 0-82293835 `(redacted).mkv' at 39157760 (1%) 537.3K/s eta:79s [Receiving data] \chunk 1975051626-2057345442 `(redacted).mkv' at 2050680170 (91%) 992.7K/s eta:6s [Receiving data] \chunk 1892757809-1975051625 `(redacted).mkv' at 1916580145 (28%) 398.3K/s eta:3m [Receiving data] \chunk 1810463992-1892757808 `(redacted).mkv' at 1870724344 (73%) 952.9K/s eta:26s [Receiving data] \chunk 1728170175-1810463991 `(redacted).mkv' at 1781450943 (64%) 698.8K/s eta:39s [Receiving data] \chunk 1645876358-1728170174 `(redacted).mkv' at 1700861062 (66%) 629.6K/s eta:35s [Receiving data] \chunk 1563582541-1645876357 `(redacted).mkv' at 1591435341 (33%) 367.3K/s eta:2m [Receiving data] \chunk 1481288724-1563582540 `(redacted).mkv' at 1542106132 (73%) 798.3K/s eta:25s [Receiving data] \chunk 1398994907-1481288723 `(redacted).mkv' at 1447720923 (59%) 631.1K/s eta:49s [Receiving data] \chunk 1316701090-1398994906 `(redacted).mkv' at 1364181922 (57%) 594.5K/s eta:52s [Receiving data] \chunk 1234407273-1316701089 `(redacted).mkv' at 1284083561 (60%) 646.4K/s eta:47s [Receiving data] \chunk 1152113456-1234407272 `(redacted).mkv' at 1190419248 (46%) 666.6K/s eta:82s [Receiving data] \chunk 1069819639-1152113455 `(redacted).mkv' at 1128179447 (70%) 700.5K/s eta:29s [Receiving data] \chunk 987525822-1069819638 `(redacted).mkv' at 1033401022 (55%) 560.4K/s eta:56s [Receiving data] \chunk 905232005-987525821 `(redacted).mkv' at 949239429 (53%) 779.0K/s eta:62s [Receiving data] \chunk 822938188-905232004 `(redacted).mkv' at 853838412 (37%) 578.5K/s eta:2m [Receiving data] \chunk 740644371-822938187 `(redacted).mkv' at 781735443 (49%) 558.3K/s eta:71s [Receiving data] \chunk 658350554-740644370 `(redacted).mkv' at 734077402 (92%) 1.06M/s eta:6s [Receiving data] \chunk 576056737-658350553 `(redacted).mkv' at 640445857 (78%) 923.6K/s eta:20s [Receiving data] \chunk 493762920-576056736 `(redacted).mkv' at 547305832 (65%) 731.4K/s eta:38s [Receiving data] \chunk 411469103-493762919 `(redacted).mkv' at 466158895 (66%) 686.8K/s eta:36s [Receiving data] \chunk 329175286-411469102 `(redacted).mkv' at 394809590 (79%) 955.9K/s eta:18s [Receiving data] \chunk 246881469-329175285 `(redacted).mkv' at 312646845 (79%) 1.05M/s eta:18s [Receiving data] \chunk 164587652-246881468 `(redacted).mkv' at 204728452 (48%) 558.6K/s eta:75s [Receiving data] \chunk 82293835-164587651 `(redacted).mkv' at 152286283 (85%) 840.1K/s eta:12s [Receiving data]
2020/06/08 24:41:10 - ERROR - seedsync.ControllerJob - Caught exception in job ControllerJob
Traceback (most recent call last):
File "/app/python/lftp/job_status_parser.py", line 81, in parse
statuses += self.__parse_queue(lines)
File "/app/python/lftp/job_status_parser.py", line 486, in __parse_queue
raise ValueError("Missing queue header line 1: {}".format(line))
ValueError: Missing queue header line 1: 2020-06-08 05:41:10 sftp://(redacted).mkv -> /downloads/tv/(redacted).mkv.lftp 0-100812963 284.0 KiB/s

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
File "/app/python/common/job.py", line 44, in run
self.execute()
File "/app/python/controller/controller_job.py", line 29, in execute
self.__controller.process()
File "/app/python/controller/controller.py", line 202, in process
self.__update_model()
File "/app/python/controller/controller.py", line 295, in __update_model
lftp_statuses = self.__lftp.status()
File "/app/python/lftp/lftp.py", line 314, in status
statuses = self.__job_status_parser.parse(statuses_str)
File "/app/python/lftp/job_status_parser.py", line 86, in parse
raise LftpJobStatusParserError("Error parsing lftp job status")
lftp.job_status_parser.LftpJobStatusParserError: Error parsing lftp job status
2020/06/08 24:41:10 - DEBUG - seedsync.ControllerJob - Calling cleanup for ControllerJob
2020/06/08 24:41:10 - DEBUG - seedsync.Controller - Exiting controller
2020/06/08 24:41:10 - ERROR - seedsync - Caught exception
Traceback (most recent call last):
File "/app/python/lftp/job_status_parser.py", line 81, in parse
statuses += self.__parse_queue(lines)
File "/app/python/lftp/job_status_parser.py", line 486, in __parse_queue
raise ValueError("Missing queue header line 1: {}".format(line))
ValueError: Missing queue header line 1: 2020-06-08 05:41:10 sftp://(redacted).mkv -> /downloads/tv/(redacted).mkv.lftp 0-100812963 284.0 KiB/s

During handling of the above exception, another exception occurred:

Traceback (most recent call last):
File "/app/python/seedsync.py", line 162, in run
controller_job.propagate_exception()
File "/app/python/common/job.py", line 77, in propagate_exception
raise exc_info[1].with_traceback(exc_info[2])
File "/app/python/common/job.py", line 44, in run
self.execute()
File "/app/python/controller/controller_job.py", line 29, in execute
self.__controller.process()
File "/app/python/controller/controller.py", line 202, in process
self.__update_model()
File "/app/python/controller/controller.py", line 295, in __update_model
lftp_statuses = self.__lftp.status()
File "/app/python/lftp/lftp.py", line 314, in status
statuses = self.__job_status_parser.parse(statuses_str)
File "/app/python/lftp/job_status_parser.py", line 86, in parse
raise LftpJobStatusParserError("Error parsing lftp job status")
lftp.job_status_parser.LftpJobStatusParserError: Error parsing lftp job status
2020/06/08 24:41:11 - DEBUG - ActiveScanner - Process received terminate flag
2020/06/08 24:41:11 - DEBUG - ActiveScanner - Exiting process
2020/06/08 24:41:14 - DEBUG - ExtractProcess - Process received terminate flag
2020/06/08 24:41:15 - DEBUG - seedsync.Controller.MPLogger - Stopped listener thread
2020/06/08 24:41:15 - INFO - seedsync.Controller - Exited controller

Likely related to #35