http-proxy_onion_test.log

2019-12-04 20:09:56,470 - wpull.application.tasks.plugin - DEBUG - Instance <wpull.application.app.Application object at 0x7fcb289d9e50> registered event Event.pipeline_begin
2019-12-04 20:09:56,473 - wpull.application.tasks.plugin - DEBUG - Instance <wpull.application.app.Application object at 0x7fcb289d9e50> registered event Event.pipeline_end
2019-12-04 20:09:56,473 - wpull.application.tasks.plugin - DEBUG - Instance <wpull.application.tasks.stats.StatsStopTask object at 0x7fcb289d96d0> registered event PluginFunctions.finishing_statistics
2019-12-04 20:09:56,473 - wpull.application.tasks.plugin - DEBUG - Instance <wpull.application.tasks.shutdown.AppStopTask object at 0x7fcb289d9a50> registered event PluginFunctions.exit_status
2019-12-04 20:09:56,473 - wpull.application.tasks.plugin - DEBUG - Instance <wpull.application.tasks.shutdown.AppStopTask object at 0x7fcb289d9a50> registered hook PluginFunctions.exit_status
2019-12-04 20:09:56,475 - yapsy - DEBUG - correct subclass tests failed for: _ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,475 - yapsy - DEBUG - correct subclass tests failed for: __builtins__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,475 - yapsy - DEBUG - correct subclass tests failed for: __cached__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: __doc__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: __file__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: __loader__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: __name__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: __package__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: __spec__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: _logger in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: gettext in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,476 - yapsy - DEBUG - correct subclass tests failed for: logging in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __builtins__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __cached__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __doc__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __file__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __loader__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __name__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __package__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: __spec__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,477 - yapsy - DEBUG - correct subclass tests failed for: event in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: LOG_DEBUG in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: LOG_VERBOSE in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __builtins__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __cached__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __doc__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __file__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __loader__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __name__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __package__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: __spec__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,479 - yapsy - DEBUG - correct subclass tests failed for: cast in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,480 - yapsy - DEBUG - correct subclass tests failed for: new_encoded_stream in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,491 - yapsy - DEBUG - correct subclass tests failed for: _ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,491 - yapsy - DEBUG - correct subclass tests failed for: __builtins__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,491 - yapsy - DEBUG - correct subclass tests failed for: __cached__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,491 - yapsy - DEBUG - correct subclass tests failed for: __doc__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: __file__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: __loader__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: __name__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: __package__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: __spec__ in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: _logger in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: atexit in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: gettext in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: logging in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,492 - yapsy - DEBUG - correct subclass tests failed for: socket in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,493 - yapsy - DEBUG - correct subclass tests failed for: tornado in /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin
Traceback (most recent call last):
  File "/usr/local/lib/python3.7/site-packages/yapsy/PluginManager.py", line 535, in loadPlugins
    is_correct_subclass = issubclass(element, self.categories_interfaces[category_name])
TypeError: issubclass() arg 1 must be a class
2019-12-04 20:09:56,493 - wpull.application.tasks.plugin - DEBUG - Found plugin arg_warning_plugin_py from /usr/local/lib/python3.7/site-packages/wpull/application/plugins/arg_warning.plugin.py.
2019-12-04 20:09:56,493 - yapsy - DEBUG - Activating plugin: Default.arg_warning_plugin_py
2019-12-04 20:09:56,493 - yapsy_loaded_plugin_arg_warning_plugin_py_0 - WARNING - WARC specifications do not handle proxies.
2019-12-04 20:09:56,493 - wpull.application.tasks.plugin - DEBUG - Found plugin server_response_plugin_py from /usr/local/lib/python3.7/site-packages/wpull/application/plugins/server_response.plugin.py.
2019-12-04 20:09:56,494 - wpull.application.tasks.plugin - DEBUG - Found plugin debug_console_plugin_py from /usr/local/lib/python3.7/site-packages/wpull/application/plugins/debug_console.plugin.py.
2019-12-04 20:09:56,494 - yapsy - DEBUG - Activating plugin: Default.debug_console_plugin_py
2019-12-04 20:09:56,494 - wpull.application.tasks.plugin - DEBUG - Found plugin download_progress_plugin_py from /usr/local/lib/python3.7/site-packages/wpull/application/plugins/download_progress.plugin.py.
2019-12-04 20:09:56,494 - yapsy - DEBUG - Activating plugin: Default.download_progress_plugin_py
2019-12-04 20:09:56,501 - wpull.database.sqltable - DEBUG - Setting pragmas.
2019-12-04 20:09:56,507 - wpull.application.tasks.database - DEBUG - Releasing any in-progress items in database.
2019-12-04 20:09:56,513 - wpull.application.tasks.sslcontext - DEBUG - Reading PEM /usr/local/lib/python3.7/site-packages/wpull/application/tasks/../../cert/ca-bundle.pem.
2019-12-04 20:09:56,522 - wpull.application.tasks.sslcontext - DEBUG - Reading PEM /etc/ssl/certs/ca-certificates.crt.
2019-12-04 20:09:56,530 - wpull.application.tasks.sslcontext - DEBUG - CA certs loaded.
2019-12-04 20:09:56,538 - wpull.application.tasks.download - DEBUG - Loaded cookies: []
2019-12-04 20:09:56,540 - root - DEBUG - Wpull needs the root logger level set to DEBUG.
2019-12-04 20:09:56,540 - wpull.warc.recorder - DEBUG - WARC file at http-proxy_onion_test.warc.gz
2019-12-04 20:09:56,541 - wpull.warc.recorder - DEBUG - Writing WARC record warcinfo.
2019-12-04 20:09:56,543 - wpull.application.tasks.database - DEBUG - Parsing URL https://3g2upl4pq6kufc4m.onion
2019-12-04 20:09:56,543 - wpull.application.tasks.database - DEBUG - Parsed URL <URLInfo at 0x7fcb27e52cb0 url=https://3g2upl4pq6kufc4m.onion/ raw=https://3g2upl4pq6kufc4m.onion>
2019-12-04 20:09:56,548 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processed item <wpull.pipeline.app.AppSession object at 0x7fcb28a4be10>
2019-12-04 20:09:56,548 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:09:56,548 - wpull.pipeline.pipeline - DEBUG - Producer stopping.
2019-12-04 20:09:56,548 - wpull.pipeline.pipeline - DEBUG - Put poison pill.
2019-12-04 20:09:56,549 - wpull.pipeline.pipeline - DEBUG - Worker quitting.
2019-12-04 20:09:56,549 - wpull.pipeline.pipeline - DEBUG - 1 worker tasks completed
2019-12-04 20:09:56,549 - wpull.pipeline.pipeline - DEBUG - Exited workers loop.
2019-12-04 20:09:56,549 - wpull.pipeline.pipeline - DEBUG - Waiting for producer to stop.
2019-12-04 20:09:56,549 - wpull.pipeline.pipeline - DEBUG - Creating worker
2019-12-04 20:09:56,549 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:09:56,559 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:09:56,561 - wpull.pipeline.pipeline - DEBUG - Worker process id=0
2019-12-04 20:09:56,562 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processing item <wpull.pipeline.session.ItemSession object at 0x7fcb289df350>
2019-12-04 20:09:56,562 - wpull.processor.web - DEBUG - Robots filter verdict True reason filters
2019-12-04 20:09:56,563 - wpull.processor.web - DEBUG - Filter verdict True reason filters
2019-12-04 20:09:56,563 - wpull.processor.web - INFO - Fetching ‘https://3g2upl4pq6kufc4m.onion/’.
2019-12-04 20:09:56,564 - wpull.protocol.http.client - DEBUG - Client fetch request <Request(GET, https://3g2upl4pq6kufc4m.onion/, HTTP/1.1)>.
2019-12-04 20:09:56,564 - wpull.network.pool - DEBUG - Check out ('3g2upl4pq6kufc4m.onion', 443, True)
2019-12-04 20:09:56,564 - wpull.proxy.client - DEBUG - Request for proxy connection.
2019-12-04 20:09:56,564 - wpull.proxy.client - DEBUG - Connecting to proxy.
2019-12-04 20:09:56,565 - wpull.network.dns - DEBUG - Lookup address 172.17.0.1.
2019-12-04 20:09:56,565 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:09:56,627 - wpull.network.dns - DEBUG - Resolved addresses: [_AddressInfo(ip_address='172.17.0.1', family=<AddressFamily.AF_INET: 2>, flow_info=None, scope_id=None)].
2019-12-04 20:09:56,627 - wpull.network.connection - DEBUG - Connecting to ('172.17.0.1', 16379).
2019-12-04 20:10:11,632 - wpull.processor.base - ERROR - Fetching ‘https://3g2upl4pq6kufc4m.onion/’ encountered an error: Connect network error: 
2019-12-04 20:10:11,633 - wpull.stats - DEBUG - Increment error Connect network error: 
2019-12-04 20:10:11,634 - wpull.pipeline.session - DEBUG - Marking URL https://3g2upl4pq6kufc4m.onion/ status Status.error.
2019-12-04 20:10:11,639 - wpull.processor.web - DEBUG - Sleeping 1.2880102208708193
2019-12-04 20:10:12,929 - wpull.protocol.http.web - DEBUG - Early close session.
2019-12-04 20:10:12,930 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processed item <wpull.pipeline.session.ItemSession object at 0x7fcb289df350>
2019-12-04 20:10:12,931 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:12,942 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:12,944 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processing item <wpull.pipeline.session.ItemSession object at 0x7fcb27e1acd0>
2019-12-04 20:10:12,944 - wpull.processor.web - DEBUG - Robots filter verdict True reason filters
2019-12-04 20:10:12,945 - wpull.processor.web - DEBUG - Filter verdict True reason filters
2019-12-04 20:10:12,945 - wpull.processor.web - INFO - Fetching ‘https://3g2upl4pq6kufc4m.onion/’.
2019-12-04 20:10:12,946 - wpull.protocol.http.client - DEBUG - Client fetch request <Request(GET, https://3g2upl4pq6kufc4m.onion/, HTTP/1.1)>.
2019-12-04 20:10:12,946 - wpull.network.pool - DEBUG - Check out ('3g2upl4pq6kufc4m.onion', 443, True)
2019-12-04 20:10:12,946 - wpull.proxy.client - DEBUG - Request for proxy connection.
2019-12-04 20:10:12,946 - wpull.proxy.client - DEBUG - Connecting to proxy.
2019-12-04 20:10:12,946 - wpull.network.dns - DEBUG - Lookup address 172.17.0.1.
2019-12-04 20:10:12,947 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:13,006 - wpull.network.dns - DEBUG - Resolved addresses: [_AddressInfo(ip_address='172.17.0.1', family=<AddressFamily.AF_INET: 2>, flow_info=None, scope_id=None)].
2019-12-04 20:10:13,007 - wpull.network.connection - DEBUG - Connecting to ('172.17.0.1', 16379).
2019-12-04 20:10:28,011 - wpull.processor.base - ERROR - Fetching ‘https://3g2upl4pq6kufc4m.onion/’ encountered an error: Connect network error: 
2019-12-04 20:10:28,012 - wpull.stats - DEBUG - Increment error Connect network error: 
2019-12-04 20:10:28,013 - wpull.pipeline.session - DEBUG - Marking URL https://3g2upl4pq6kufc4m.onion/ status Status.error.
2019-12-04 20:10:28,017 - wpull.processor.web - DEBUG - Sleeping 2.4673865168579967
2019-12-04 20:10:30,488 - wpull.protocol.http.web - DEBUG - Early close session.
2019-12-04 20:10:30,489 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processed item <wpull.pipeline.session.ItemSession object at 0x7fcb27e1acd0>
2019-12-04 20:10:30,490 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:30,501 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:30,503 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processing item <wpull.pipeline.session.ItemSession object at 0x7fcb289df350>
2019-12-04 20:10:30,504 - wpull.processor.web - DEBUG - Robots filter verdict True reason filters
2019-12-04 20:10:30,504 - wpull.processor.web - DEBUG - Filter verdict True reason filters
2019-12-04 20:10:30,504 - wpull.processor.web - INFO - Fetching ‘https://3g2upl4pq6kufc4m.onion/’.
2019-12-04 20:10:30,506 - wpull.protocol.http.client - DEBUG - Client fetch request <Request(GET, https://3g2upl4pq6kufc4m.onion/, HTTP/1.1)>.
2019-12-04 20:10:30,506 - wpull.network.pool - DEBUG - Check out ('3g2upl4pq6kufc4m.onion', 443, True)
2019-12-04 20:10:30,506 - wpull.proxy.client - DEBUG - Request for proxy connection.
2019-12-04 20:10:30,506 - wpull.proxy.client - DEBUG - Connecting to proxy.
2019-12-04 20:10:30,506 - wpull.network.dns - DEBUG - Lookup address 172.17.0.1.
2019-12-04 20:10:30,506 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:30,559 - wpull.network.dns - DEBUG - Resolved addresses: [_AddressInfo(ip_address='172.17.0.1', family=<AddressFamily.AF_INET: 2>, flow_info=None, scope_id=None)].
2019-12-04 20:10:30,559 - wpull.network.connection - DEBUG - Connecting to ('172.17.0.1', 16379).
2019-12-04 20:10:45,565 - wpull.processor.base - ERROR - Fetching ‘https://3g2upl4pq6kufc4m.onion/’ encountered an error: Connect network error: 
2019-12-04 20:10:45,566 - wpull.stats - DEBUG - Increment error Connect network error: 
2019-12-04 20:10:45,566 - wpull.pipeline.session - DEBUG - Marking URL https://3g2upl4pq6kufc4m.onion/ status Status.error.
2019-12-04 20:10:45,571 - wpull.processor.web - DEBUG - Sleeping 5.036848185832291
2019-12-04 20:10:50,614 - wpull.protocol.http.web - DEBUG - Early close session.
2019-12-04 20:10:50,615 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processed item <wpull.pipeline.session.ItemSession object at 0x7fcb289df350>
2019-12-04 20:10:50,617 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,621 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,623 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processing item <wpull.pipeline.session.ItemSession object at 0x7fcb289df150>
2019-12-04 20:10:50,624 - wpull.processor.web - DEBUG - Robots filter verdict False reason filters
2019-12-04 20:10:50,624 - wpull.pipeline.session - DEBUG - Skipping ‘https://3g2upl4pq6kufc4m.onion/’.
2019-12-04 20:10:50,625 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processed item <wpull.pipeline.session.ItemSession object at 0x7fcb289df150>
2019-12-04 20:10:50,625 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,627 - wpull.pipeline.pipeline - DEBUG - Producer stopping.
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Put poison pill.
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Worker quitting.
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - 1 worker tasks completed
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Exited workers loop.
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Waiting for producer to stop.
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Creating worker
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Worker process id=0
2019-12-04 20:10:50,628 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processing item <wpull.pipeline.app.AppSession object at 0x7fcb28a4be10>
2019-12-04 20:10:50,629 - wpull.application.tasks.stats - INFO - FINISHED.
2019-12-04 20:10:50,629 - wpull.application.tasks.stats - INFO - Duration: 0:00:54. Speed: -- B/s.
2019-12-04 20:10:50,629 - wpull.application.tasks.stats - INFO - Downloaded: 0 files, 0.0 B.
2019-12-04 20:10:50,629 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processed item <wpull.pipeline.app.AppSession object at 0x7fcb28a4be10>
2019-12-04 20:10:50,629 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,629 - wpull.pipeline.pipeline - DEBUG - Producer stopping.
2019-12-04 20:10:50,629 - wpull.pipeline.pipeline - DEBUG - Put poison pill.
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Worker quitting.
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - 1 worker tasks completed
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Exited workers loop.
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Waiting for producer to stop.
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Creating worker
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Get item from source
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Worker process id=0
2019-12-04 20:10:50,630 - wpull.pipeline.pipeline - DEBUG - Worker id 0 Processing item <wpull.pipeline.app.AppSession object at 0x7fcb28a4be10>
2019-12-04 20:10:50,631 - wpull.warc.recorder - DEBUG - Writing WARC record resource.