2026-05-29 22:49:01 [scrapy.utils.log] INFO: Scrapy 2.10.0 started (bot: retriever)
2026-05-29 22:49:01 [scrapy.utils.log] INFO: Versions: lxml 5.1.0.0, libxml2 2.12.3, cssselect 1.2.0, parsel 1.9.0, w3lib 2.0.0, Twisted 22.4.0, Python 3.10.12 (main, Mar 3 2026, 11:56:32) [GCC 11.4.0], pyOpenSSL 24.1.0 (OpenSSL 3.2.1 30 Jan 2024), cryptography 42.0.5, Platform Linux-6.8.0-1030-aws-x86_64-with-glibc2.35
2026-05-29 22:49:01 [scrapy.addons] INFO: Enabled addons:
[]
2026-05-29 22:49:01 [scrapy.crawler] INFO: Overridden settings:
{'AUTOTHROTTLE_ENABLED': True,
'BOT_NAME': 'retriever',
'HTTPCACHE_EXPIRATION_SECS': 86400,
'IMAGES_STORE_S3_ACL': 'public-read',
'LOG_FILE': '/home/scrapyd/logs/loknow_spiders_prod/ImageSpider/91ad08005bb011f1bdc0c3bbae71ecef.log',
'LOG_FORMATTER': 'loknow_spiders.logging.PoliteLogFormatter',
'LOG_LEVEL': 'INFO',
'NEWSPIDER_MODULE': 'loknow_spiders.spiders',
'SPIDER_MODULES': ['loknow_spiders.spiders'],
'TELNETCONSOLE_ENABLED': False,
'USER_AGENT': 'AdRetriever (https://adretriever.com)'}
2026-05-29 22:49:01 [py.warnings] WARNING: /home/scrapyd/venv/lib/python3.10/site-packages/scrapy/utils/request.py:248: ScrapyDeprecationWarning: '2.6' is a deprecated value for the 'REQUEST_FINGERPRINTER_IMPLEMENTATION' setting.
It is also the default value. In other words, it is normal to get this warning if you have not defined a value for the 'REQUEST_FINGERPRINTER_IMPLEMENTATION' setting. This is so for backward compatibility reasons, but it will change in a future version of Scrapy.
See the documentation of the 'REQUEST_FINGERPRINTER_IMPLEMENTATION' setting for information on how to handle this deprecation.
return cls(crawler)
2026-05-29 22:49:01 [scrapy.middleware] INFO: Enabled extensions:
['scrapy.extensions.corestats.CoreStats',
'scrapy.extensions.memusage.MemoryUsage',
'scrapy.extensions.feedexport.FeedExporter',
'scrapy.extensions.logstats.LogStats',
'scrapy.extensions.throttle.AutoThrottle']
2026-05-29 22:49:01 [ImageSpider] INFO: Current Spider Environment set to: prod
2026-05-29 22:49:01 [ImageSpider] INFO: Retrieving AWS secret: spider_prod_secrets
2026-05-29 22:49:02 [botocore.credentials] INFO: Found credentials in shared credentials file: ~/.aws/credentials
2026-05-29 22:49:02 [ImageSpider] INFO: In base spider ml_kwargs is None and scrape_type is inventory
2026-05-29 22:49:02 [scrapy.middleware] INFO: Enabled downloader middlewares:
['scrapy.downloadermiddlewares.httpauth.HttpAuthMiddleware',
'scrapy.downloadermiddlewares.downloadtimeout.DownloadTimeoutMiddleware',
'scrapy.downloadermiddlewares.defaultheaders.DefaultHeadersMiddleware',
'scrapy.downloadermiddlewares.useragent.UserAgentMiddleware',
'loknow_spiders.middlewares.ThrottlingRetryMiddleware',
'scrapy.downloadermiddlewares.redirect.MetaRefreshMiddleware',
'scrapy.downloadermiddlewares.httpcompression.HttpCompressionMiddleware',
'scrapy.downloadermiddlewares.redirect.RedirectMiddleware',
'scrapy.downloadermiddlewares.cookies.CookiesMiddleware',
'scrapy.downloadermiddlewares.httpproxy.HttpProxyMiddleware',
'scrapy.downloadermiddlewares.stats.DownloaderStats']
2026-05-29 22:49:02 [scrapy.middleware] INFO: Enabled spider middlewares:
['scrapy.spidermiddlewares.httperror.HttpErrorMiddleware',
'scrapy.spidermiddlewares.offsite.OffsiteMiddleware',
'loknow_spiders.middlewares.RetrieverSpiderMiddleware',
'scrapy.spidermiddlewares.referer.RefererMiddleware',
'scrapy.spidermiddlewares.urllength.UrlLengthMiddleware',
'scrapy.spidermiddlewares.depth.DepthMiddleware']
2026-05-29 22:49:05 [botocore.credentials] INFO: Found credentials in shared credentials file: ~/.aws/credentials
2026-05-29 22:49:05 [scrapy.middleware] INFO: Enabled item pipelines:
['loknow_spiders.pipelines.ImageUrlsValidationPipeline']
2026-05-29 22:49:05 [scrapy.core.engine] INFO: Spider opened
2026-05-29 22:49:05 [loknow_spiders] INFO: Scrape ID: 9346e546
2026-05-29 22:49:05 [scrapy.extensions.logstats] INFO: Crawled 0 pages (at 0 pages/min), scraped 0 items (at 0 items/min)
2026-05-29 22:49:06 [ImageSpider] INFO: Generated ID from Etag value: "c663d7acf64f1c172e499ebfd92581f9" => _c663d7acf64f1c172e499ebfd92581f9
2026-05-29 22:49:06 [ImageSpider] WARNING: Failed to validate image: Image not accessible - https://www.rentcafe.com/dmslivecafe/2/153572/Gertrude.png
2026-05-29 22:49:08 [ImageSpider] INFO: Generated ID from Etag value: "9b4f92e84e2f03e9cf8580f51243ee65" => _9b4f92e84e2f03e9cf8580f51243ee65
2026-05-29 22:49:11 [ImageSpider] INFO: Generated ID from Etag value: "cfdc96c57af0a9640f7449ebba21d777" => _cfdc96c57af0a9640f7449ebba21d777
2026-05-29 22:49:11 [ImageSpider] INFO: Generated ID from Etag value: "354513a74c14171516445879a3f81468" => _354513a74c14171516445879a3f81468
2026-05-29 22:49:12 [ImageSpider] INFO: Generated ID from Etag value: "92417e8c6546b2c8458c86713751b687" => _92417e8c6546b2c8458c86713751b687
2026-05-29 22:49:13 [ImageSpider] INFO: Generated ID from Etag value: "50f7a77dc2a9352c4076f8b3bfff1678" => _50f7a77dc2a9352c4076f8b3bfff1678
2026-05-29 22:49:14 [ImageSpider] INFO: Generated ID from Etag value: "c9381d648928912604594468c5cd2bdf" => _c9381d648928912604594468c5cd2bdf
2026-05-29 22:49:14 [ImageSpider] INFO: Generated ID from Etag value: "4941b9f04422b216f50548bbd535516f" => _4941b9f04422b216f50548bbd535516f
2026-05-29 22:49:14 [ImageSpider] INFO: Generated ID from Etag value: "31ed7ad0e6c482e8324f622a05bd7ccf" => _31ed7ad0e6c482e8324f622a05bd7ccf
2026-05-29 22:49:14 [ImageSpider] INFO: Generated ID from Etag value: "0ef8b0a38764cffeb2a8deb11ac8c9c0" => _0ef8b0a38764cffeb2a8deb11ac8c9c0
2026-05-29 22:49:15 [scrapy.core.engine] INFO: Closing spider (finished)
2026-05-29 22:49:15 [ImageSpider] INFO: RetrieverAPI is making requests to https://api.adretriever.com with headers {'Authorization': 'Token 96dfb640234f1d676d6fa726f8eae6e7aab44cda'}
2026-05-29 22:49:15 [root] INFO: Making post request to https://api.adretriever.com/api/validated_urls/9346e546
2026-05-29 22:49:15 [loknow_spiders] INFO: Cache hit rate: 96.15%
2026-05-29 22:49:15 [loknow_spiders] INFO: Cached images: _c663d7acf64f1c172e499ebfd92581f9: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/the%20zu.jpg
_9b4f92e84e2f03e9cf8580f51243ee65: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/the%20spot%20at%20tuxedo%20point%20amenities.jpg
_cfdc96c57af0a9640f7449ebba21d777: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/top01.jpg
_354513a74c14171516445879a3f81468: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/the%20spot%20at%20pembina%20-%20community%20image.jpg
_92417e8c6546b2c8458c86713751b687: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/halo%20exterior.jpg
_50f7a77dc2a9352c4076f8b3bfff1678: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/tamarack%20pointe%20-%20community%20image.jpg
_c9381d648928912604594468c5cd2bdf: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/the%20ascot%20-%20community%20image.jpg
_4941b9f04422b216f50548bbd535516f: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/gallery%203(1).png
_31ed7ad0e6c482e8324f622a05bd7ccf: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/slider-1.png
_0ef8b0a38764cffeb2a8deb11ac8c9c0: https://resource.rentcafe.com/image/upload//q_auto,f_auto,w_600,h_400,c_lfill,g_auto/s3/2/153572/kent_towers_1155-grant-community%20image.jpg
2026-05-29 22:49:15 [loknow_spiders] INFO: Uncached images: None
2026-05-29 22:49:15 [scrapy.extensions.feedexport] INFO: Stored jsonlines feed (26 items) in: file:///home/scrapyd/items/loknow_spiders_prod/ImageSpider/91ad08005bb011f1bdc0c3bbae71ecef.jl
2026-05-29 22:49:15 [scrapy.statscollectors] INFO: Dumping Scrapy stats:
{'downloader/request_bytes': 3472,
'downloader/request_count': 11,
'downloader/request_method_count/HEAD': 11,
'downloader/response_bytes': 8928,
'downloader/response_count': 11,
'downloader/response_status_count/200': 10,
'downloader/response_status_count/403': 1,
'dupefilter/filtered': 15,
'elapsed_time_seconds': 9.839899,
'feedexport/success_count/FileFeedStorage': 1,
'finish_reason': 'finished',
'finish_time': datetime.datetime(2026, 5, 29, 22, 49, 15, 407622),
'item_scraped_count': 26,
'log_count/INFO': 30,
'log_count/WARNING': 2,
'memusage/max': 133054464,
'memusage/startup': 133054464,
'response_received_count': 11,
'scheduler/dequeued': 11,
'scheduler/dequeued/memory': 11,
'scheduler/enqueued': 11,
'scheduler/enqueued/memory': 11,
'start_time': datetime.datetime(2026, 5, 29, 22, 49, 5, 567723)}
2026-05-29 22:49:15 [scrapy.core.engine] INFO: Spider closed (finished)