Traceback (most recent call last): File "/app/client.py", line 455, in _start task.run(item, itemType, author, ident, full, queuedFor, ctx) File "/app/client.py", line 210, in run self._run(*args, **kwargs) File "/app/client.py", line 202, 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', '--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/1878681476']' returned non-zero exit status 1. /data/v18786814761697906312.958824.tmp Logs: [2023-10-21 16:38:32,967] INFO PRINT <__main__.Logger object at 0x7fcdbeb86e20> (407/write/client.py) [2023-10-21 16:38:32,967] INFO PRINT <_io.TextIOWrapper name='' mode='w' encoding='utf-8'> (407/write/client.py) [2023-10-21 16:38:32,967] INFO PRINT Finished RedirectStdout for item v:1878681476 (407/write/client.py) [2023-10-21 16:38:32,967] INFO PRINT Starting DownloadData for item v1878681476 (407/write/client.py) [2023-10-21 16:38:32,968] INFO PRINT Starting warcprox for Item 1878681476 (407/write/client.py) [2023-10-21 16:38:36,980] DEBUG Starting new HTTP connection (1): localhost:4553 (245/_new_conn/connectionpool.py) [2023-10-21 16:38:36,982] DEBUG http://localhost:4553 "WARCPROX_WRITE_RECORD /burnthetwitch_client_version HTTP/1.1" 204 0 (547/_make_request/connectionpool.py) [2023-10-21 16:38:36,982] INFO PRINT Downloading metadata (407/write/client.py) [2023-10-21 16:38:36,982] INFO Running subprocess: ['yt-dlp', '--ignore-config', '--skip-download', '--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/1878681476'] (31/run_with_log/subprocess_with_logging.py) [2023-10-21 16:38:37,725] INFO STDOUT [twitch:vod] Extracting URL: https://twitch.tv/videos/1878681476 (94/run_with_log/subprocess_with_logging.py) [2023-10-21 16:38:37,726] INFO STDOUT [twitch:vod] 1878681476: Downloading stream metadata GraphQL (94/run_with_log/subprocess_with_logging.py) [2023-10-21 16:38:38,098] INFO STDERR ERROR: [twitch:vod] 1878681476: Video 1878681476 does not exist (85/run_with_log/subprocess_with_logging.py) [2023-10-21 16:38:38,128] INFO Process exited with status 1 (103/run_with_log/subprocess_with_logging.py) [2023-10-21 16:38:38,128] INFO PRINT Terminating warcprox (407/write/client.py) [2023-10-21 16:38:40,665] INFO PRINT Caught exception! (407/write/client.py) [2023-10-21 16:38:40,665] INFO PRINT Sending to server and aborting. (407/write/client.py) Warcprox log: 2023-10-21 16:38:33,179 195 INFO MainThread warcprox.warcproxy.WarcProxy.__init__(mitmproxy.py:617) 100 proxy threads 2023-10-21 16:38:33,407 195 NOTICE MainThread warcprox.warcproxy.WarcProxy.server_activate(warcproxy.py:493) listening on 127.0.0.1:4553 2023-10-21 16:38:33,408 195 INFO MainThread warcprox.dedup.DedupDb.start(dedup.py:98) creating new deduplication database ./warcprox.sqlite 2023-10-21 16:38:33,411 195 INFO DedupLoader(tid=197) warcprox.BasePostfetchProcessor._run(__init__.py:134) starting up 2023-10-21 16:38:33,411 195 INFO WarcWriterProcessor(tid=198) warcprox.writerthread.WarcWriterProcessor._run(__init__.py:134) starting up 2023-10-21 16:38:33,422 195 INFO DedupDb(tid=199) warcprox.BasePostfetchProcessor._run(__init__.py:134) starting up 2023-10-21 16:38:33,422 195 INFO StatsProcessor(tid=200) warcprox.stats.StatsProcessor._run(__init__.py:134) starting up 2023-10-21 16:38:33,423 195 INFO StatsProcessor(tid=200) warcprox.stats.StatsProcessor._startup(stats.py:108) opening existing stats database ./warcprox.sqlite 2023-10-21 16:38:33,423 195 INFO CrawlLogger(tid=201) warcprox.BasePostfetchProcessor._run(__init__.py:134) starting up 2023-10-21 16:38:33,423 195 INFO RunningStats(tid=202) warcprox.BasePostfetchProcessor._run(__init__.py:134) starting up 2023-10-21 16:38:33,435 195 INFO StatsProcessor(tid=200) warcprox.stats.StatsProcessor._startup(stats.py:125) created table buckets_of_stats in ./warcprox.sqlite 2023-10-21 16:38:36,981 195 INFO WarcWriterProcessor(tid=198) 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 16:38:36,983 195 INFO WarcWriterProcessor(tid=198) warcprox.writerthread.WarcWriterProcessor._log(writerthread.py:133) 127.0.0.1 204 WARCPROX_WRITE_RECORD /burnthetwitch_client_version text=plain size=95 sha1:28b942d7f9756aa5e7810943b1f0efe153103f14 resource WARCPROX-20231021163836982-00000-sinjrblk.warc.gz offset=338 2023-10-21 16:38:37,483 195 INFO StatsProcessor(tid=200) warcprox.stats.StatsProcessor._get_process_put(__init__.py:207) gathered batch of 1 in 2.05 sec 2023-10-21 16:38:38,096 195 INFO WarcWriterProcessor(tid=198) warcprox.writerthread.WarcWriterProcessor._log(writerthread.py:133) 127.0.0.1 200 POST https://gql.twitch.tv/gql application/json size=351 sha1:7437d99d6042de0d6c89370395dc8baddea55f97 response WARCPROX-20231021163836982-00000-sinjrblk.warc.gz offset=716 2023-10-21 16:38:38,729 195 NOTICE MainThread warcprox.warcproxy.WarcProxy.server_close(warcproxy.py:501) shutting down 2023-10-21 16:38:39,096 195 INFO DedupLoader(tid=197) warcprox.BasePostfetchProcessor._run(__init__.py:144) shutting down 2023-10-21 16:38:39,097 195 INFO WarcWriterProcessor(tid=198) warcprox.writerthread.WarcWriterProcessor._run(__init__.py:144) shutting down 2023-10-21 16:38:39,109 195 INFO DedupDb(tid=199) warcprox.BasePostfetchProcessor._run(__init__.py:144) shutting down 2023-10-21 16:38:39,610 195 INFO StatsProcessor(tid=200) warcprox.stats.StatsProcessor._get_process_put(__init__.py:207) gathered batch of 1 in 2.10 sec 2023-10-21 16:38:40,134 195 INFO StatsProcessor(tid=200) warcprox.stats.StatsProcessor._run(__init__.py:144) shutting down 2023-10-21 16:38:40,134 195 INFO CrawlLogger(tid=201) warcprox.BasePostfetchProcessor._run(__init__.py:144) shutting down 2023-10-21 16:38:40,634 195 INFO RunningStats(tid=202) warcprox.BasePostfetchProcessor._run(__init__.py:144) shutting down