Traceback (most recent call last):
  File "/app/client.py", line 465, in _start
    task.run(item, itemType, author, ident, full, queuedFor, ctx)
  File "/app/client.py", line 220, in run
    self._run(*args, **kwargs)
  File "/app/client.py", line 212, in _run
    self._run_vod(item)
  File "/app/client.py", line 104, in _run_vod
    open_and_wait([
  File "/app/client.py", line 35, in open_and_wait
    process = subprocess_with_logging.run_with_log(args, shell=False, preexec_fn=os.setpgrp, check=True)
  File "/app/subprocess_with_logging.py", line 105, in run_with_log
    raise subprocess.CalledProcessError(returncode = p.returncode, cmd = args)
subprocess.CalledProcessError: Command '['yt-dlp', '--ignore-config', '--skip-download', '--trim-filenames', '200', '--ignore-no-formats-error', '--write-info-json', '--write-description', '--write-thumbnail', '--write-all-thumbnails', '--no-check-certificate', '--retries', '4', '--limit-rate', '300k', '-o', 'infojson:%(id)s', '--proxy', 'http://localhost:4553', 'https://twitch.tv/videos/1895844695']' returned non-zero exit status 1.

/data/v18958446951697911957.2416193.tmp
Logs:
[2023-10-21 18:12:37,246] INFO PRINT <__main__.Logger object at 0x7fd0b15402b0> (417/write/client.py)
[2023-10-21 18:12:37,246] INFO PRINT <_io.TextIOWrapper name='<stdout>' mode='w' encoding='utf-8'> (417/write/client.py)
[2023-10-21 18:12:37,246] INFO PRINT Finished RedirectStdout for item v:1895844695 (417/write/client.py)
[2023-10-21 18:12:37,246] INFO PRINT Starting DownloadData for item v1895844695 (417/write/client.py)
[2023-10-21 18:12:37,246] INFO PRINT Starting warcprox for Item 1895844695 (417/write/client.py)
[2023-10-21 18:12:41,255] DEBUG Starting new HTTP connection (1): localhost:4553 (245/_new_conn/connectionpool.py)
[2023-10-21 18:12:41,258] DEBUG http://localhost:4553 "WARCPROX_WRITE_RECORD /burnthetwitch_client_version HTTP/1.1" 204 0 (547/_make_request/connectionpool.py)
[2023-10-21 18:12:41,258] INFO PRINT Downloading metadata (417/write/client.py)
[2023-10-21 18:12:41,258] INFO Running subprocess: ['yt-dlp', '--ignore-config', '--skip-download', '--trim-filenames', '200', '--ignore-no-formats-error', '--write-info-json', '--write-description', '--write-thumbnail', '--write-all-thumbnails', '--no-check-certificate', '--retries', '4', '--limit-rate', '300k', '-o', 'infojson:%(id)s', '--proxy', 'http://localhost:4553', 'https://twitch.tv/videos/1895844695'] (31/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:12:42,032] INFO STDOUT [twitch:vod] Extracting URL: https://twitch.tv/videos/1895844695 (94/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:12:42,033] INFO STDOUT [twitch:vod] 1895844695: Downloading stream metadata GraphQL (94/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:12:42,273] INFO STDERR ERROR: [twitch:vod] 1895844695: Video 1895844695 does not exist (85/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:12:42,308] INFO Process exited with status 1 (103/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:12:42,308] INFO PRINT Terminating warcprox (417/write/client.py)
[2023-10-21 18:12:44,360] INFO PRINT Caught exception! (417/write/client.py)
[2023-10-21 18:12:44,361] INFO PRINT Sending to server and aborting. (417/write/client.py)


Warcprox log:
2023-10-21 18:12:37,463 85 INFO MainThread warcprox.warcproxy.WarcProxy.__init__(mitmproxy.py:617) 100 proxy threads
2023-10-21 18:12:37,589 85 NOTICE MainThread warcprox.warcproxy.WarcProxy.server_activate(warcproxy.py:493) listening on 127.0.0.1:4553
2023-10-21 18:12:37,590 85 INFO MainThread warcprox.dedup.DedupDb.start(dedup.py:98) creating new deduplication database ./warcprox.sqlite
2023-10-21 18:12:37,591 85 INFO DedupLoader(tid=87) warcprox.BasePostfetchProcessor._run(__init__.py:134) <DedupLoader(DedupLoader(tid=87), started 140416195376896)> starting up
2023-10-21 18:12:37,592 85 INFO WarcWriterProcessor(tid=88) warcprox.writerthread.WarcWriterProcessor._run(__init__.py:134) <WarcWriterProcessor(WarcWriterProcessor(tid=88), started 140416186984192)> starting up
2023-10-21 18:12:37,604 85 INFO DedupDb(tid=89) warcprox.BasePostfetchProcessor._run(__init__.py:134) <ListenerPostfetchProcessor(DedupDb(tid=89), started 140415969785600)> starting up
2023-10-21 18:12:37,604 85 INFO StatsProcessor(tid=90) warcprox.stats.StatsProcessor._run(__init__.py:134) <StatsProcessor(StatsProcessor(tid=90), started 140415961392896)> starting up
2023-10-21 18:12:37,604 85 INFO StatsProcessor(tid=90) warcprox.stats.StatsProcessor._startup(stats.py:108) opening existing stats database ./warcprox.sqlite
2023-10-21 18:12:37,604 85 INFO CrawlLogger(tid=91) warcprox.BasePostfetchProcessor._run(__init__.py:134) <ListenerPostfetchProcessor(CrawlLogger(tid=91), started 140415953000192)> starting up
2023-10-21 18:12:37,604 85 INFO RunningStats(tid=92) warcprox.BasePostfetchProcessor._run(__init__.py:134) <ListenerPostfetchProcessor(RunningStats(tid=92), started 140415944607488)> starting up
2023-10-21 18:12:37,617 85 INFO StatsProcessor(tid=90) warcprox.stats.StatsProcessor._startup(stats.py:125) created table buckets_of_stats in ./warcprox.sqlite
2023-10-21 18:12:41,257 85 INFO WarcWriterProcessor(tid=88) warcprox.writer.WarcWriter.open(writer.py:93) warc destination directory ./warcs doesn't exist, creating it
/usr/local/lib/python3.9/site-packages/hanzo/warctools/record.py:174: FutureWarning: GzipFile was opened for writing, but this will change in future Python releases.  Specify the mode argument for opening it for writing.
  out = GzipFile(fileobj=out)
2023-10-21 18:12:41,259 85 INFO WarcWriterProcessor(tid=88) warcprox.writerthread.WarcWriterProcessor._log(writerthread.py:133) 127.0.0.1 204 WARCPROX_WRITE_RECORD /burnthetwitch_client_version text=plain size=95 sha1:d021c28ded5cc0306d8bb0e3209ae690757c319e resource WARCPROX-20231021181241258-00000-8q9zvh4f.warc.gz offset=338
2023-10-21 18:12:41,759 85 INFO StatsProcessor(tid=90) warcprox.stats.StatsProcessor._get_process_put(__init__.py:207) gathered batch of 1 in 2.14 sec
2023-10-21 18:12:42,270 85 INFO WarcWriterProcessor(tid=88) warcprox.writerthread.WarcWriterProcessor._log(writerthread.py:133) 127.0.0.1 200 POST https://gql.twitch.tv/gql application/json size=350 sha1:6fbb0a76166f1f8c00c5f4cb0026c7241ef34fda response WARCPROX-20231021181241258-00000-8q9zvh4f.warc.gz offset=717
2023-10-21 18:12:43,037 85 NOTICE MainThread warcprox.warcproxy.WarcProxy.server_close(warcproxy.py:501) shutting down
2023-10-21 18:12:43,269 85 INFO DedupLoader(tid=87) warcprox.BasePostfetchProcessor._run(__init__.py:144) <DedupLoader(DedupLoader(tid=87), started 140416195376896)> shutting down
2023-10-21 18:12:43,270 85 INFO WarcWriterProcessor(tid=88) warcprox.writerthread.WarcWriterProcessor._run(__init__.py:144) <WarcWriterProcessor(WarcWriterProcessor(tid=88), started 140416186984192)> shutting down
2023-10-21 18:12:43,284 85 INFO DedupDb(tid=89) warcprox.BasePostfetchProcessor._run(__init__.py:144) <ListenerPostfetchProcessor(DedupDb(tid=89), started 140415969785600)> shutting down
2023-10-21 18:12:43,284 85 INFO StatsProcessor(tid=90) warcprox.stats.StatsProcessor._get_process_put(__init__.py:207) gathered batch of 1 in 1.48 sec
2023-10-21 18:12:43,809 85 INFO StatsProcessor(tid=90) warcprox.stats.StatsProcessor._run(__init__.py:144) <StatsProcessor(StatsProcessor(tid=90), started 140415961392896)> shutting down
2023-10-21 18:12:43,810 85 INFO CrawlLogger(tid=91) warcprox.BasePostfetchProcessor._run(__init__.py:144) <ListenerPostfetchProcessor(CrawlLogger(tid=91), started 140415953000192)> shutting down
2023-10-21 18:12:44,310 85 INFO RunningStats(tid=92) warcprox.BasePostfetchProcessor._run(__init__.py:144) <ListenerPostfetchProcessor(RunningStats(tid=92), started 140415944607488)> shutting down