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/1890842313']' returned non-zero exit status 1.

/data/v18908423131697912052.4712527.tmp
Logs:
[2023-10-21 18:14:12,479] INFO PRINT <__main__.Logger object at 0x7ff843bc3220> (417/write/client.py)
[2023-10-21 18:14:12,479] INFO PRINT <_io.TextIOWrapper name='<stdout>' mode='w' encoding='utf-8'> (417/write/client.py)
[2023-10-21 18:14:12,479] INFO PRINT Finished RedirectStdout for item v:1890842313 (417/write/client.py)
[2023-10-21 18:14:12,479] INFO PRINT Starting DownloadData for item v1890842313 (417/write/client.py)
[2023-10-21 18:14:12,479] INFO PRINT Starting warcprox for Item 1890842313 (417/write/client.py)
[2023-10-21 18:14:16,488] DEBUG Starting new HTTP connection (1): localhost:4553 (245/_new_conn/connectionpool.py)
[2023-10-21 18:14:16,491] DEBUG http://localhost:4553 "WARCPROX_WRITE_RECORD /burnthetwitch_client_version HTTP/1.1" 204 0 (547/_make_request/connectionpool.py)
[2023-10-21 18:14:16,491] INFO PRINT Downloading metadata (417/write/client.py)
[2023-10-21 18:14:16,492] 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/1890842313'] (31/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:14:17,237] INFO STDOUT [twitch:vod] Extracting URL: https://twitch.tv/videos/1890842313 (94/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:14:17,238] INFO STDOUT [twitch:vod] 1890842313: Downloading stream metadata GraphQL (94/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:14:17,569] INFO STDERR ERROR: [twitch:vod] 1890842313: Video 1890842313 does not exist (85/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:14:17,599] INFO Process exited with status 1 (103/run_with_log/subprocess_with_logging.py)
[2023-10-21 18:14:17,599] INFO PRINT Terminating warcprox (417/write/client.py)
[2023-10-21 18:14:19,652] INFO PRINT Caught exception! (417/write/client.py)
[2023-10-21 18:14:19,653] INFO PRINT Sending to server and aborting. (417/write/client.py)


Warcprox log:
2023-10-21 18:14:12,696 66 INFO MainThread warcprox.warcproxy.WarcProxy.__init__(mitmproxy.py:617) 100 proxy threads
2023-10-21 18:14:12,794 66 NOTICE MainThread warcprox.warcproxy.WarcProxy.server_activate(warcproxy.py:493) listening on 127.0.0.1:4553
2023-10-21 18:14:12,796 66 INFO MainThread warcprox.dedup.DedupDb.start(dedup.py:98) creating new deduplication database ./warcprox.sqlite
2023-10-21 18:14:12,799 66 INFO DedupLoader(tid=68) warcprox.BasePostfetchProcessor._run(__init__.py:134) <DedupLoader(DedupLoader(tid=68), started 139682388121344)> starting up
2023-10-21 18:14:12,799 66 INFO WarcWriterProcessor(tid=69) warcprox.writerthread.WarcWriterProcessor._run(__init__.py:134) <WarcWriterProcessor(WarcWriterProcessor(tid=69), started 139682379728640)> starting up
2023-10-21 18:14:12,810 66 INFO DedupDb(tid=70) warcprox.BasePostfetchProcessor._run(__init__.py:134) <ListenerPostfetchProcessor(DedupDb(tid=70), started 139682371168000)> starting up
2023-10-21 18:14:12,810 66 INFO StatsProcessor(tid=71) warcprox.stats.StatsProcessor._run(__init__.py:134) <StatsProcessor(StatsProcessor(tid=71), started 139682362513152)> starting up
2023-10-21 18:14:12,810 66 INFO StatsProcessor(tid=71) warcprox.stats.StatsProcessor._startup(stats.py:108) opening existing stats database ./warcprox.sqlite
2023-10-21 18:14:12,810 66 INFO CrawlLogger(tid=72) warcprox.BasePostfetchProcessor._run(__init__.py:134) <ListenerPostfetchProcessor(CrawlLogger(tid=72), started 139682354120448)> starting up
2023-10-21 18:14:12,810 66 INFO RunningStats(tid=73) warcprox.BasePostfetchProcessor._run(__init__.py:134) <ListenerPostfetchProcessor(RunningStats(tid=73), started 139682345727744)> starting up
2023-10-21 18:14:12,823 66 INFO StatsProcessor(tid=71) warcprox.stats.StatsProcessor._startup(stats.py:125) created table buckets_of_stats in ./warcprox.sqlite
2023-10-21 18:14:16,490 66 INFO WarcWriterProcessor(tid=69) 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:14:16,492 66 INFO WarcWriterProcessor(tid=69) 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-20231021181416491-00000-6auxznkd.warc.gz offset=337
2023-10-21 18:14:16,992 66 INFO StatsProcessor(tid=71) warcprox.stats.StatsProcessor._get_process_put(__init__.py:207) gathered batch of 1 in 2.17 sec
2023-10-21 18:14:17,553 66 INFO WarcWriterProcessor(tid=69) warcprox.writerthread.WarcWriterProcessor._log(writerthread.py:133) 127.0.0.1 200 POST https://gql.twitch.tv/gql application/json size=353 sha1:da05ca2fdc3e97501d76a08ba5850d3aa20b80d7 response WARCPROX-20231021181416491-00000-6auxznkd.warc.gz offset=717
2023-10-21 18:14:18,242 66 NOTICE MainThread warcprox.warcproxy.WarcProxy.server_close(warcproxy.py:501) shutting down
2023-10-21 18:14:18,552 66 INFO DedupLoader(tid=68) warcprox.BasePostfetchProcessor._run(__init__.py:144) <DedupLoader(DedupLoader(tid=68), started 139682388121344)> shutting down
2023-10-21 18:14:18,553 66 INFO WarcWriterProcessor(tid=69) warcprox.writerthread.WarcWriterProcessor._run(__init__.py:144) <WarcWriterProcessor(WarcWriterProcessor(tid=69), started 139682379728640)> shutting down
2023-10-21 18:14:18,579 66 INFO DedupDb(tid=70) warcprox.BasePostfetchProcessor._run(__init__.py:144) <ListenerPostfetchProcessor(DedupDb(tid=70), started 139682371168000)> shutting down
2023-10-21 18:14:19,079 66 INFO StatsProcessor(tid=71) warcprox.stats.StatsProcessor._get_process_put(__init__.py:207) gathered batch of 1 in 2.06 sec
2023-10-21 18:14:19,606 66 INFO StatsProcessor(tid=71) warcprox.stats.StatsProcessor._run(__init__.py:144) <StatsProcessor(StatsProcessor(tid=71), started 139682362513152)> shutting down
2023-10-21 18:14:19,607 66 INFO CrawlLogger(tid=72) warcprox.BasePostfetchProcessor._run(__init__.py:144) <ListenerPostfetchProcessor(CrawlLogger(tid=72), started 139682354120448)> shutting down
2023-10-21 18:14:19,607 66 INFO RunningStats(tid=73) warcprox.BasePostfetchProcessor._run(__init__.py:144) <ListenerPostfetchProcessor(RunningStats(tid=73), started 139682345727744)> shutting down