Skip to content

Can't scan using Nikon Coolscan 5000ED #744

Description

@treypentecost

HI Marcin, as discussed on r/analogcommunity, here is the relevant info from the log file (I think):

[2026-08-01 11:43:56] INFO     negpy.negpy.kernel.system.parallel: CPU parallel kernels: enabled (override=None, platform=linux)
[2026-08-03 12:04:41] INFO     negpy.negpy.kernel.system.parallel: CPU parallel kernels: enabled (override=None, platform=linux)
[2026-08-03 12:04:41] INFO     negpy.negpy.infrastructure.storage.local_asset_store: LocalAssetStore initialized at /home/[username]/Documents/NegPy/cache
[2026-08-03 12:04:42] INFO     negpy.negpy.infrastructure.gpu.device: WebGPU Backend: Intel(R) HD Graphics 530 (SKL GT2) (IntegratedGPU) via Vulkan
[2026-08-03 12:04:42] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 12:04:42] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 12:04:42] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 12:04:44] WARNING  negpy.negpy.desktop.view.main_window: No monitor ICC profile detected; preview will assume sRGB
[2026-08-03 12:07:26] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:012']
[2026-08-03 12:09:48] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:012']
[2026-08-03 12:12:08] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:012']
[2026-08-03 12:14:27] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:012']
[2026-08-03 12:26:56] ERROR    negpy.negpy.desktop.workers.scan_worker: Batch frame 1 scan failed
Traceback (most recent call last):
  File "negpy/desktop/workers/scan_worker.py", line 211, in run_batch
  File "negpy/services/scanning/service.py", line 87, in run_scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 833, in scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 877, in _scan_on_device
  File "negpy/infrastructure/scanners/sane_backend.py", line 452, in _require_writable_option
RuntimeError: Requested SANE option 'frame' is inactive
[2026-08-03 12:27:04] ERROR    negpy.negpy.desktop.workers.scan_worker: Batch frame 1 scan failed
Traceback (most recent call last):
  File "negpy/desktop/workers/scan_worker.py", line 211, in run_batch
  File "negpy/services/scanning/service.py", line 87, in run_scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 833, in scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 877, in _scan_on_device
  File "negpy/infrastructure/scanners/sane_backend.py", line 452, in _require_writable_option
RuntimeError: Requested SANE option 'frame' is inactive
[2026-08-03 12:27:29] ERROR    negpy.negpy.desktop.workers.scan_worker: Batch frame 1 scan failed
Traceback (most recent call last):
  File "negpy/desktop/workers/scan_worker.py", line 211, in run_batch
  File "negpy/services/scanning/service.py", line 87, in run_scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 833, in scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 877, in _scan_on_device
  File "negpy/infrastructure/scanners/sane_backend.py", line 452, in _require_writable_option
RuntimeError: Requested SANE option 'frame' is inactive
[2026-08-03 13:13:54] ERROR    negpy.negpy.desktop.workers.scan_worker: Batch frame 1 scan failed
Traceback (most recent call last):
  File "negpy/desktop/workers/scan_worker.py", line 211, in run_batch
  File "negpy/services/scanning/service.py", line 87, in run_scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 833, in scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 877, in _scan_on_device
  File "negpy/infrastructure/scanners/sane_backend.py", line 452, in _require_writable_option
RuntimeError: Requested SANE option 'frame' is inactive
[2026-08-03 13:14:00] INFO     negpy.negpy.services.rendering.gpu_engine: GPUEngine: VRAM resources released
[2026-08-03 13:14:00] INFO     negpy.negpy.services.rendering.gpu_engine: GPUEngine: Engine decommissioned
[2026-08-03 13:14:10] INFO     negpy.negpy.kernel.system.parallel: CPU parallel kernels: enabled (override=None, platform=linux)
[2026-08-03 13:14:10] INFO     negpy.negpy.infrastructure.storage.local_asset_store: LocalAssetStore initialized at /home/[username]/Documents/NegPy/cache
[2026-08-03 13:14:11] INFO     negpy.negpy.infrastructure.gpu.device: WebGPU Backend: Intel(R) HD Graphics 530 (SKL GT2) (IntegratedGPU) via Vulkan
[2026-08-03 13:14:11] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 13:14:11] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 13:14:11] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 13:14:14] WARNING  negpy.negpy.desktop.view.main_window: No monitor ICC profile detected; preview will assume sRGB
[2026-08-03 13:16:39] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:012']
[2026-08-03 13:16:45] ERROR    negpy.negpy.desktop.workers.scan_worker: Batch frame 1 scan failed
Traceback (most recent call last):
  File "negpy/desktop/workers/scan_worker.py", line 211, in run_batch
  File "negpy/services/scanning/service.py", line 87, in run_scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 833, in scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 877, in _scan_on_device
  File "negpy/infrastructure/scanners/sane_backend.py", line 452, in _require_writable_option
RuntimeError: Requested SANE option 'frame' is inactive
[2026-08-03 13:31:30] ERROR    negpy.negpy.desktop.workers.scan_worker: Batch frame 1 scan failed
Traceback (most recent call last):
  File "negpy/desktop/workers/scan_worker.py", line 211, in run_batch
  File "negpy/services/scanning/service.py", line 87, in run_scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 833, in scan
  File "negpy/infrastructure/scanners/sane_backend.py", line 941, in _scan_on_device
  File "sane.py", line 277, in start
_sane.error: Error during device I/O
[2026-08-03 13:34:29] WARNING  negpy.negpy.services.scanning.service: Transient scanner I/O on coolscan3:usb:libusb:001:012 (attempt 1/3), retrying: RGB scan failed: Error during device I/O
[2026-08-03 13:35:20] INFO     negpy.negpy.kernel.system.parallel: CPU parallel kernels: enabled (override=None, platform=linux)
[2026-08-03 13:35:20] INFO     negpy.negpy.infrastructure.storage.local_asset_store: LocalAssetStore initialized at /home/[username]/Documents/NegPy/cache
[2026-08-03 13:35:21] INFO     negpy.negpy.infrastructure.gpu.device: WebGPU Backend: Intel(R) HD Graphics 530 (SKL GT2) (IntegratedGPU) via Vulkan
[2026-08-03 13:35:21] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 13:35:21] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 13:35:21] INFO     negpy.negpy.services.rendering.image_processor: ImageProcessor: Acceleration backend ready
[2026-08-03 13:35:24] WARNING  negpy.negpy.desktop.view.main_window: No monitor ICC profile detected; preview will assume sRGB
[2026-08-03 13:36:49] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:012']
[2026-08-03 13:36:49] WARNING  negpy.negpy.infrastructure.scanners.sane_backend: Could not probe device coolscan3:usb:libusb:001:012: Invalid argument
[2026-08-03 13:36:49] INFO     negpy.negpy.services.rendering.gpu_engine: GPUEngine: VRAM resources released
[2026-08-03 13:36:49] INFO     negpy.negpy.services.rendering.gpu_engine: GPUEngine: Engine decommissioned
[2026-08-03 13:37:47] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:013']
[2026-08-03 13:40:10] INFO     negpy.negpy.infrastructure.scanners.sane_backend: SANE found 1 raw device(s): ['coolscan3:usb:libusb:001:013']
[2026-08-03 13:40:10] WARNING  negpy.negpy.infrastructure.scanners.sane_backend: Could not probe device coolscan3:usb:libusb:001:013: Invalid argument
[2026-08-03 13:40:10] INFO     negpy.negpy.services.rendering.gpu_engine: GPUEngine: VRAM resources released
[2026-08-03 13:40:10] INFO     negpy.negpy.services.rendering.gpu_engine: GPUEngine: Engine decommissioned

As I mentioned, after waiting for about two minutes, the scanner does connect, and I was able to control it, but it crashed after trying to actually scan.

Let me know if you need more information.

Metadata

Metadata

Assignees

No one assigned

    Labels

    No labels
    No labels

    Projects

    No projects

    Milestone

    No milestone

    Relationships

    None yet

    Development

    No branches or pull requests

    Issue actions