CUPS and Sabayon 5.5 with canon PIXMA MP150 [Solved]

[xenophon2009]

I have an sabayon 5.5 on my laptop with a printer canon Pixma MP150. The printer is installed correctly with CUPS and guttenprint. It's the default printer. But when I try to print something it's impossible !!!! Nothing is printing!

when I go to : http://localhost:631/jobs/ it's written the printer is stopped !

In states there is :

Idle - "Filter "/usr/libexec/cups/filter/rastertogutenprint.5.1" for printer "MP150" not available: No such file or directory"

How can I solve the problem ?

[Fitzcarraldo]

Is there a different version of that file? Open a Konsole/Terminal window and enter the following command in order to find out:

Code: Select all

ls -la /usr/libexec/cups/filter/rastertogutenprint*

[xenophon2009]

sabayon toto # ls -la /usr/libexec/cups/filter/rastertogutenprint*
-rwxr-xr-x 1 root root 550492 21 juil. 2010 /usr/libexec/cups/filter/rastertogutenprint.5.2
sabayon toto #

[Fitzcarraldo]

Yes, it's as I suspected, because the version of net-print/gutenprint in the Entropy repository is 5.2.5-r1, so I would have expected rastertogutenprint.5.2, not 5.1.

The latest version of the Gutenprint drivers in Portage is 5.2.6, so try installing those as it will probably fix the mismatch. As root in a Konsole/Terminal window:

Code: Select all

emerge --sync
layman -a sabayon # Do not worry is a message tells you the sabayon overlay is already added.
layman -S
# _IF_ the above layman commands fail with an error message about git not being installed, install git and then repeat the layman commands:
equo install git
emerge -1v =gutenprint-5.2.6
equo rescue spmsync

The last command above is to tell Entropy what you did via Portage.

Then launch the CUPS browser interface (http://localhost:631/), delete the printer and reinstall it.

[raman]

Anybody request new gutenprint in entropy on bugzilla?

[xenophon2009]

I've done all what you said but I can't print :
error message is the system is waiting for the printer !

[Fitzcarraldo]

Post the console output from the following commands, run as root user in a Konsole/Terminal window:

Code: Select all

dmesg
lsusb
ls /etc/udev/rules.d/

Then, still with the Konsole/Terminal window open, unplug the USB cable from your PC, run the following command, then plug in the USB cable again:

Code: Select all

tail -f /var/log/messages

[xenophon2009]

Code: Select all

sabayon toto # dmesg
72896] rt73usb 1-2:1.0: no reset_resume for driver rt73usb?
[ 7528.317384] ata4.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[ 7528.317389] ata4.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
[ 7528.358252] ata4.00: configured for UDMA/33
[ 7529.331051] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[ 7529.399892] ata1.00: unexpected _GTF length (8)
[ 7529.400803] ata1.00: unexpected _GTF length (8)
[ 7529.400808] ata1.00: configured for UDMA/133
[ 7529.429200] PM: resume of devices complete after 2603.086 msecs
[ 7529.692120] ieee80211 phy1: Selected rate control algorithm 'minstrel_ht'
[ 7529.692361] Registered led device: rt73usb-phy1::radio
[ 7529.692389] Registered led device: rt73usb-phy1::assoc
[ 7529.692416] Registered led device: rt73usb-phy1::quality
[ 7529.703670] Restarting all filesystems ...
[ 7529.704996] Restarting tasks ... done.
[ 7529.713511] video LNXVIDEO:00: Restoring backlight state
[ 7532.183528] ata1.00: configured for UDMA/133
[ 7532.183532] ata1: EH complete
[ 7532.183639] sd 2:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[ 7532.462174] EXT4-fs (sda5): re-mounted. Opts: commit=600
[ 7532.781094] EXT4-fs (sda6): re-mounted. Opts: commit=600
[ 7532.853751] sky2 0000:06:00.0: eth0: enabling interface                                                                                                                         
[ 7532.854279] ADDRCONF(NETDEV_UP): eth0: link is not ready                                                                                                                         
[ 7532.941525] ADDRCONF(NETDEV_UP): wlan0: link is not ready                                                                                                                       
[ 7538.095984] ADDRCONF(NETDEV_UP): wlan0: link is not ready                                                                                                                       
[ 7751.506755] ata1.00: configured for UDMA/133                                                                                                                                     
[ 7751.506759] ata1: EH complete                                                                                                                                                   
[ 7751.506870] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA                                                                             
[ 7751.643556] EXT4-fs (sda5): re-mounted. Opts: commit=0                                                                                                                           
[ 7752.267518] EXT4-fs (sda6): re-mounted. Opts: commit=0                                                                                                                           
[10584.578746] ata1.00: configured for UDMA/133                                                                                                                                     
[10584.578751] ata1: EH complete                                                                                                                                                   
[10584.578887] sd 2:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[10584.775445] EXT4-fs (sda5): re-mounted. Opts: commit=600
[10584.947843] EXT4-fs (sda6): re-mounted. Opts: commit=600
[10621.662029] sky2 0000:06:00.0: eth0: disabling interface
[10622.978383] ata1.00: configured for UDMA/133
[10622.978387] ata1: EH complete
[10622.978525] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[10623.060964] EXT4-fs (sda5): re-mounted. Opts: commit=0
[10623.288891] EXT4-fs (sda6): re-mounted. Opts: commit=0
[10624.265433] usb 1-1: USB disconnect, address 2
[10625.860499] PM: Syncing filesystems ... done.
[10625.869097] Stopping fuse filesystems.
[10625.869102] Freezing user space processes ... (elapsed 0.01 seconds) done.
[10625.884406] Stopping normal filesystems.
[10625.889568] Freezing remaining freezable tasks ...
[10625.920049] usb 1-1: new high speed USB device using ehci_hcd and address 4
[10626.049392] uvcvideo: Found UVC 1.00 device USB 2.0 Camera (04f2:b024)
[10626.083482] input: USB 2.0 Camera as /devices/pci0000:00/0000:00:1a.7/usb1/1-1/1-1:1.0/input/input10
[10626.087068] (elapsed 0.19 seconds) done.
[10626.087085] Suspending console(s) (use no_console_suspend to debug)
[10626.089311] sd 2:0:0:0: [sda] Synchronizing SCSI cache
[10626.089362] sd 2:0:0:0: [sda] Stopping disk
[10626.141620] lirc_ite8709 00:02: disabled
[10626.141741] ACPI handle has no context!
[10626.141749] sdhci-pci 0000:07:01.2: PCI INT B disabled
[10626.141756] ACPI handle has no context!
[10626.142840] ACPI handle has no context!
[10626.142847] sdhci-pci 0000:07:01.1: PCI INT B disabled
[10626.142854] ACPI handle has no context!
[10626.472602] pci 0000:00:1f.3: PCI INT C disabled
[10626.472767] ata_piix 0000:00:1f.1: PCI INT A disabled
[10626.472801] ehci_hcd 0000:00:1d.7: PCI INT A disabled
[10626.472815] uhci_hcd 0000:00:1d.2: PCI INT C disabled
[10626.472831] uhci_hcd 0000:00:1d.1: PCI INT B disabled
[10626.472845] uhci_hcd 0000:00:1d.0: PCI INT A disabled
[10626.508051] ehci_hcd 0000:00:1a.7: PCI INT C disabled
[10626.508066] uhci_hcd 0000:00:1a.1: PCI INT B disabled
[10626.508081] uhci_hcd 0000:00:1a.0: PCI INT A disabled
[10626.572113] ACPI handle has no context!
[10626.585163] HDA Intel 0000:00:1b.0: PCI INT A disabled
[10627.195783] PM: suspend of devices complete after 1108.079 msecs
[10627.218148] PM: late suspend of devices complete after 22.359 msecs
[10627.218257] ACPI: Preparing to enter system sleep state S3
[10627.223301] PM: Saving platform NVS memory
[10627.230185] Disabling non-boot CPUs ...
[10627.235162] CPU 1 is now offline
[10627.235164] SMP alternatives: switching to UP code
[10627.273725] Extended CMOS year: 2000
[10627.273725] Back to C!
[10627.273725] PM: Restoring platform NVS memory
[10627.273725] Extended CMOS year: 2000
[10627.273725] Enabling non-boot CPUs ...
[10627.287027] SMP alternatives: switching to SMP code
[10627.317348] Booting Node 0 Processor 1 APIC 0x1
[10627.273432] Initializing CPU#1
[10627.407383] CPU1 is up
[10627.407604] ACPI: Waking up from system sleep state S3
[10627.408233] pci 0000:00:01.0: restoring config space at offset 0x6 (was 0x0, writing 0x10100)
[10627.408240] pci 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010)
[10627.408279] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10627.408315] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10627.408360] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[10627.408414] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[10627.408422] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102)
[10627.408458] pci 0000:00:1c.0: restoring config space at offset 0xf (was 0x40100, writing 0x4010b)
[10627.408473] pci 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0xc031c021)
[10627.408479] pci 0000:00:1c.0: restoring config space at offset 0x8 (was 0xfff0, writing 0xc010c000)
[10627.408485] pci 0000:00:1c.0: restoring config space at offset 0x7 (was 0x200000f0, writing 0x5050)
[10627.408496] pci 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[10627.408538] pci 0000:00:1c.1: restoring config space at offset 0xf (was 0x40200, writing 0x4020b)
[10627.408552] pci 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xf1f1f001)
[10627.408558] pci 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xf3f0f200)
[10627.408564] pci 0000:00:1c.1: restoring config space at offset 0x7 (was 0x0, writing 0x3030)
[10627.408575] pci 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[10627.408583] pci 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
[10627.408621] pci 0000:00:1c.5: restoring config space at offset 0xf (was 0x40200, writing 0x4020b)
[10627.408635] pci 0000:00:1c.5: restoring config space at offset 0x9 (was 0x10001, writing 0xc051c041)
[10627.408642] pci 0000:00:1c.5: restoring config space at offset 0x8 (was 0x0, writing 0xf400f400)
[10627.408648] pci 0000:00:1c.5: restoring config space at offset 0x7 (was 0x20000000, writing 0x4040)
[10627.408659] pci 0000:00:1c.5: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[10627.408667] pci 0000:00:1c.5: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
[10627.408716] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10627.408751] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10627.408786] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10627.408831] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[10627.408867] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[10627.408873] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xf410f410)
[10627.408879] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x228000f0)
[10627.408894] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100107)
[10627.408947] pci 0000:00:1f.0: restoring config space at offset 0x1 (was 0x2100007, writing 0x2100107)
[10627.408967] ata_piix 0000:00:1f.1: restoring config space at offset 0xf (was 0x100, writing 0x1ff)
[10627.409026] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x205)
[10627.409053] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[10627.409111] pci 0000:00:1f.3: restoring config space at offset 0x4 (was 0x0, writing 0xc0600000)
[10627.409177] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[10627.409193] nvidia 0000:01:00.0: restoring config space at offset 0x9 (was 0x1, writing 0x2001)
[10627.409201] nvidia 0000:01:00.0: restoring config space at offset 0x7 (was 0x4, writing 0xcc000004)
[10627.409210] nvidia 0000:01:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xd000000c)
[10627.409216] nvidia 0000:01:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xce000000)
[10627.409227] nvidia 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
[10627.409296] sky2 0000:06:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[10627.409322] sky2 0000:06:00.0: restoring config space at offset 0x6 (was 0x1, writing 0x4001)
[10627.409332] sky2 0000:06:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xf4000004)
[10627.409340] sky2 0000:06:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[10627.409349] sky2 0000:06:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100507)
[10627.409434] firewire_ohci 0000:07:01.0: restoring config space at offset 0x4 (was 0x0, writing 0xf4100000)
[10627.409441] firewire_ohci 0000:07:01.0: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10627.409449] firewire_ohci 0000:07:01.0: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10627.409494] sdhci-pci 0000:07:01.1: restoring config space at offset 0x4 (was 0x0, writing 0xf4100800)
[10627.409501] sdhci-pci 0000:07:01.1: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10627.409509] sdhci-pci 0000:07:01.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10627.409553] sdhci-pci 0000:07:01.2: restoring config space at offset 0x4 (was 0x0, writing 0xf4100c00)
[10627.409560] sdhci-pci 0000:07:01.2: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10627.409568] sdhci-pci 0000:07:01.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10627.409612] pci 0000:07:01.3: restoring config space at offset 0x4 (was 0x0, writing 0xf4101000)
[10627.409618] pci 0000:07:01.3: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10627.409626] pci 0000:07:01.3: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10627.409960] PM: early resume of devices complete after 1.802 msecs
[10627.410112] pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[10627.410117] pci 0000:00:01.0: setting latency timer to 64
[10627.410127] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[10627.410138] uhci_hcd 0000:00:1a.0: setting latency timer to 64
[10627.410168] usb usb3: root hub lost power or was reset
[10627.410183] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21
[10627.410191] uhci_hcd 0000:00:1a.1: setting latency timer to 64
[10627.410221] usb usb4: root hub lost power or was reset
[10627.410237] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[10627.410248] ehci_hcd 0000:00:1a.7: setting latency timer to 64
[10627.410271] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[10627.410283] HDA Intel 0000:00:1b.0: setting latency timer to 64
[10627.410308] pci 0000:00:1c.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[10627.410316] pci 0000:00:1c.0: setting latency timer to 64
[10627.410327] pci 0000:00:1c.1: PCI INT B -> GSI 16 (level, low) -> IRQ 16
[10627.410335] pci 0000:00:1c.1: setting latency timer to 64
[10627.410345] pci 0000:00:1c.5: PCI INT B -> GSI 16 (level, low) -> IRQ 16
[10627.410350] HDA Intel 0000:00:1b.0: irq 42 for MSI/MSI-X
[10627.410352] pci 0000:00:1c.5: setting latency timer to 64
[10627.410363] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[10627.410374] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[10627.410402] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[10627.410405] usb usb5: root hub lost power or was reset
[10627.410411] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[10627.410453] usb usb6: root hub lost power or was reset
[10627.410472] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[10627.410485] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[10627.410493] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[10627.410500] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[10627.410516] usb usb7: root hub lost power or was reset
[10627.410534] pci 0000:00:1e.0: setting latency timer to 64
[10627.410548] ata_piix 0000:00:1f.1: PCI INT A -> GSI 19 (level, low) -> IRQ 19
[10627.410555] ata_piix 0000:00:1f.1: setting latency timer to 64
[10627.410564] ahci 0000:00:1f.2: setting latency timer to 64
[10627.410579] pci 0000:00:1f.3: PCI INT C -> GSI 19 (level, low) -> IRQ 19
[10627.461072] sdhci-pci 0000:07:01.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[10627.461076] sdhci-pci 0000:07:01.1: Will use DMA mode even though HW doesn't fully claim to support it.
[10627.462147] sdhci-pci 0000:07:01.2: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[10627.462211] firewire_core: skipped bus generations, destroying all nodes
[10627.471040] sd 2:0:0:0: [sda] Starting disk
[10627.581776] lirc_ite8709 00:02: activated
[10627.716071] ata2: SATA link down (SStatus 0 SControl 300)
[10627.717055] ata3: SATA link down (SStatus 0 SControl 300)
[10627.759025] usb 1-2: reset high speed USB device using ehci_hcd and address 3
[10627.965875] rt73usb 1-2:1.0: no reset_resume for driver rt73usb?
[10628.012023] usb 1-1: reset high speed USB device using ehci_hcd and address 4
[10628.103363] firewire_core: rediscovered device fw0
[10628.866379] ata4.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[10628.866384] ata4.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
[10628.904254] ata4.00: configured for UDMA/33
[10629.909053] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[10629.998124] ata1.00: unexpected _GTF length (8)
[10629.999035] ata1.00: unexpected _GTF length (8)
[10629.999040] ata1.00: configured for UDMA/133
[10630.027422] PM: resume of devices complete after 2617.401 msecs
[10630.290378] ieee80211 phy2: Selected rate control algorithm 'minstrel_ht'
[10630.290627] Registered led device: rt73usb-phy2::radio
[10630.290654] Registered led device: rt73usb-phy2::assoc
[10630.290681] Registered led device: rt73usb-phy2::quality
[10630.291801] Restarting all filesystems ...
[10630.293081] Restarting tasks ... done.
[10630.335027] video LNXVIDEO:00: Restoring backlight state
[10631.369277] ata1.00: configured for UDMA/133
[10631.369281] ata1: EH complete
[10631.369442] sd 2:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[10631.989134] EXT4-fs (sda5): re-mounted. Opts: commit=600
[10632.191118] EXT4-fs (sda6): re-mounted. Opts: commit=600
[10632.367146] sky2 0000:06:00.0: eth0: enabling interface
[10632.367394] ADDRCONF(NETDEV_UP): eth0: link is not ready
[10632.460645] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[10632.563026] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[10650.213040] sky2 0000:06:00.0: eth0: disabling interface
[10651.227427] usb 1-1: USB disconnect, address 4
[10651.334052] usb 1-1: new high speed USB device using ehci_hcd and address 5
[10651.463998] uvcvideo: Found UVC 1.00 device USB 2.0 Camera (04f2:b024)
[10651.498246] input: USB 2.0 Camera as /devices/pci0000:00/0000:00:1a.7/usb1/1-1/1-1:1.0/input/input11
[10651.498755] ata1.00: configured for UDMA/133
[10651.498760] ata1: EH complete
[10651.498875] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[10651.901461] EXT4-fs (sda5): re-mounted. Opts: commit=0
[10651.992876] EXT4-fs (sda6): re-mounted. Opts: commit=0
[10654.164318] PM: Syncing filesystems ... done.
[10654.169061] Stopping fuse filesystems.
[10654.169066] Freezing user space processes ... (elapsed 0.01 seconds) done.
[10654.184376] Stopping normal filesystems.
[10654.189937] Freezing remaining freezable tasks ... (elapsed 0.01 seconds) done.
[10654.201071] Suspending console(s) (use no_console_suspend to debug)
[10654.203115] sd 2:0:0:0: [sda] Synchronizing SCSI cache
[10654.254820] lirc_ite8709 00:02: disabled
[10654.254984] ACPI handle has no context!
[10654.254987] ACPI handle has no context!
[10654.254997] sdhci-pci 0000:07:01.1: PCI INT B disabled
[10654.255000] sdhci-pci 0000:07:01.2: PCI INT B disabled
[10654.255019] ACPI handle has no context!
[10654.255021] ACPI handle has no context!
[10654.255161] pci 0000:00:1f.3: PCI INT C disabled
[10654.255223] ehci_hcd 0000:00:1d.7: PCI INT A disabled
[10654.255236] uhci_hcd 0000:00:1d.2: PCI INT C disabled
[10654.255248] uhci_hcd 0000:00:1d.1: PCI INT B disabled
[10654.255266] uhci_hcd 0000:00:1d.0: PCI INT A disabled
[10654.255723] ehci_hcd 0000:00:1a.7: PCI INT C disabled
[10654.255741] uhci_hcd 0000:00:1a.1: PCI INT B disabled
[10654.255756] uhci_hcd 0000:00:1a.0: PCI INT A disabled
[10654.255921] ata_piix 0000:00:1f.1: PCI INT A disabled
[10654.257121] ACPI handle has no context!
[10654.356192] HDA Intel 0000:00:1b.0: PCI INT A disabled
[10654.361342] sd 2:0:0:0: [sda] Stopping disk
[10655.336633] PM: suspend of devices complete after 1134.941 msecs
[10655.359148] PM: late suspend of devices complete after 22.508 msecs
[10655.359257] ACPI: Preparing to enter system sleep state S3
[10655.364301] PM: Saving platform NVS memory
[10655.371183] Disabling non-boot CPUs ...
[10655.376163] CPU 1 is now offline
[10655.376165] SMP alternatives: switching to UP code
[10655.414731] Extended CMOS year: 2000
[10655.414731] Back to C!
[10655.414731] PM: Restoring platform NVS memory
[10655.414731] Extended CMOS year: 2000
[10655.414731] Enabling non-boot CPUs ...
[10655.428027] SMP alternatives: switching to SMP code
[10655.458313] Booting Node 0 Processor 1 APIC 0x1
[10655.414442] Initializing CPU#1
[10655.541369] CPU1 is up
[10655.541588] ACPI: Waking up from system sleep state S3
[10655.542215] pci 0000:00:01.0: restoring config space at offset 0x6 (was 0x0, writing 0x10100)
[10655.542221] pci 0000:00:01.0: restoring config space at offset 0x3 (was 0x10000, writing 0x10010)
[10655.542261] uhci_hcd 0000:00:1a.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10655.542297] uhci_hcd 0000:00:1a.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10655.542342] ehci_hcd 0000:00:1a.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[10655.542397] HDA Intel 0000:00:1b.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[10655.542405] HDA Intel 0000:00:1b.0: restoring config space at offset 0x1 (was 0x100106, writing 0x100102)
[10655.542441] pci 0000:00:1c.0: restoring config space at offset 0xf (was 0x40100, writing 0x4010b)
[10655.542455] pci 0000:00:1c.0: restoring config space at offset 0x9 (was 0x1fff1, writing 0xc031c021)
[10655.542461] pci 0000:00:1c.0: restoring config space at offset 0x8 (was 0xfff0, writing 0xc010c000)
[10655.542468] pci 0000:00:1c.0: restoring config space at offset 0x7 (was 0x200000f0, writing 0x20005050)
[10655.542479] pci 0000:00:1c.0: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[10655.542520] pci 0000:00:1c.1: restoring config space at offset 0xf (was 0x40200, writing 0x4020b)
[10655.542535] pci 0000:00:1c.1: restoring config space at offset 0x9 (was 0x10001, writing 0xf1f1f001)
[10655.542541] pci 0000:00:1c.1: restoring config space at offset 0x8 (was 0x0, writing 0xf3f0f200)
[10655.542547] pci 0000:00:1c.1: restoring config space at offset 0x7 (was 0x0, writing 0x3030)
[10655.542558] pci 0000:00:1c.1: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[10655.542566] pci 0000:00:1c.1: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
[10655.542604] pci 0000:00:1c.5: restoring config space at offset 0xf (was 0x40200, writing 0x4020b)
[10655.542619] pci 0000:00:1c.5: restoring config space at offset 0x9 (was 0x10001, writing 0xc051c041)
[10655.542625] pci 0000:00:1c.5: restoring config space at offset 0x8 (was 0x0, writing 0xf400f400)
[10655.542631] pci 0000:00:1c.5: restoring config space at offset 0x7 (was 0x20000000, writing 0x20004040)
[10655.542642] pci 0000:00:1c.5: restoring config space at offset 0x3 (was 0x810000, writing 0x810010)
[10655.542650] pci 0000:00:1c.5: restoring config space at offset 0x1 (was 0x100000, writing 0x100107)
[10655.542699] uhci_hcd 0000:00:1d.0: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10655.542734] uhci_hcd 0000:00:1d.1: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10655.542769] uhci_hcd 0000:00:1d.2: restoring config space at offset 0x1 (was 0x2800005, writing 0x2800001)
[10655.542814] ehci_hcd 0000:00:1d.7: restoring config space at offset 0x1 (was 0x2900106, writing 0x2900102)
[10655.542850] pci 0000:00:1e.0: restoring config space at offset 0x9 (was 0x10001, writing 0x1fff1)
[10655.542856] pci 0000:00:1e.0: restoring config space at offset 0x8 (was 0x0, writing 0xf410f410)
[10655.542863] pci 0000:00:1e.0: restoring config space at offset 0x7 (was 0x22800000, writing 0x228000f0)
[10655.542877] pci 0000:00:1e.0: restoring config space at offset 0x1 (was 0x100004, writing 0x100107)
[10655.542930] pci 0000:00:1f.0: restoring config space at offset 0x1 (was 0x2100007, writing 0x2100107)
[10655.542950] ata_piix 0000:00:1f.1: restoring config space at offset 0xf (was 0x100, writing 0x1ff)
[10655.542997] ahci 0000:00:1f.2: restoring config space at offset 0xf (was 0x200, writing 0x205)
[10655.543036] ahci 0000:00:1f.2: restoring config space at offset 0x1 (was 0x2b00007, writing 0x2b00407)
[10655.543093] pci 0000:00:1f.3: restoring config space at offset 0x4 (was 0x0, writing 0xc0600000)
[10655.543160] nvidia 0000:01:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[10655.543175] nvidia 0000:01:00.0: restoring config space at offset 0x9 (was 0x1, writing 0x2001)
[10655.543183] nvidia 0000:01:00.0: restoring config space at offset 0x7 (was 0x4, writing 0xcc000004)
[10655.543192] nvidia 0000:01:00.0: restoring config space at offset 0x5 (was 0xc, writing 0xd000000c)
[10655.543199] nvidia 0000:01:00.0: restoring config space at offset 0x4 (was 0x0, writing 0xce000000)
[10655.543209] nvidia 0000:01:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100007)
[10655.543278] sky2 0000:06:00.0: restoring config space at offset 0xf (was 0x100, writing 0x10b)
[10655.543304] sky2 0000:06:00.0: restoring config space at offset 0x6 (was 0x1, writing 0x4001)
[10655.543314] sky2 0000:06:00.0: restoring config space at offset 0x4 (was 0x4, writing 0xf4000004)
[10655.543322] sky2 0000:06:00.0: restoring config space at offset 0x3 (was 0x0, writing 0x10)
[10655.543332] sky2 0000:06:00.0: restoring config space at offset 0x1 (was 0x100000, writing 0x100507)
[10655.543416] firewire_ohci 0000:07:01.0: restoring config space at offset 0x4 (was 0x0, writing 0xf4100000)
[10655.543423] firewire_ohci 0000:07:01.0: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10655.543431] firewire_ohci 0000:07:01.0: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10655.543475] sdhci-pci 0000:07:01.1: restoring config space at offset 0x4 (was 0x0, writing 0xf4100800)
[10655.543481] sdhci-pci 0000:07:01.1: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10655.543489] sdhci-pci 0000:07:01.1: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10655.543534] sdhci-pci 0000:07:01.2: restoring config space at offset 0x4 (was 0x0, writing 0xf4100c00)
[10655.543540] sdhci-pci 0000:07:01.2: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10655.543548] sdhci-pci 0000:07:01.2: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10655.543590] pci 0000:07:01.3: restoring config space at offset 0x4 (was 0x0, writing 0xf4101000)
[10655.543597] pci 0000:07:01.3: restoring config space at offset 0x3 (was 0x800000, writing 0x802010)
[10655.543604] pci 0000:07:01.3: restoring config space at offset 0x1 (was 0x2100000, writing 0x2100106)
[10655.543938] PM: early resume of devices complete after 1.799 msecs
[10655.544112] pci 0000:00:01.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[10655.544116] pci 0000:00:01.0: setting latency timer to 64
[10655.544125] uhci_hcd 0000:00:1a.0: PCI INT A -> GSI 16 (level, low) -> IRQ 16
[10655.544132] uhci_hcd 0000:00:1a.0: setting latency timer to 64
[10655.544161] usb usb3: root hub lost power or was reset
[10655.544174] uhci_hcd 0000:00:1a.1: PCI INT B -> GSI 21 (level, low) -> IRQ 21
[10655.544182] uhci_hcd 0000:00:1a.1: setting latency timer to 64
[10655.544209] usb usb4: root hub lost power or was reset
[10655.544225] ehci_hcd 0000:00:1a.7: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[10655.544232] ehci_hcd 0000:00:1a.7: setting latency timer to 64
[10655.544281] HDA Intel 0000:00:1b.0: PCI INT A -> GSI 22 (level, low) -> IRQ 22
[10655.544288] HDA Intel 0000:00:1b.0: setting latency timer to 64
[10655.544336] HDA Intel 0000:00:1b.0: irq 42 for MSI/MSI-X
[10655.544377] pci 0000:00:1c.0: PCI INT A -> GSI 17 (level, low) -> IRQ 17
[10655.544383] pci 0000:00:1c.0: setting latency timer to 64
[10655.544391] pci 0000:00:1c.1: PCI INT B -> GSI 16 (level, low) -> IRQ 16
[10655.544397] pci 0000:00:1c.1: setting latency timer to 64
[10655.544405] pci 0000:00:1c.5: PCI INT B -> GSI 16 (level, low) -> IRQ 16
[10655.544411] pci 0000:00:1c.5: setting latency timer to 64
[10655.544419] uhci_hcd 0000:00:1d.0: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[10655.544427] uhci_hcd 0000:00:1d.0: setting latency timer to 64
[10655.544455] usb usb5: root hub lost power or was reset
[10655.544470] uhci_hcd 0000:00:1d.1: PCI INT B -> GSI 19 (level, low) -> IRQ 19
[10655.544477] uhci_hcd 0000:00:1d.1: setting latency timer to 64
[10655.544504] usb usb6: root hub lost power or was reset
[10655.544518] uhci_hcd 0000:00:1d.2: PCI INT C -> GSI 18 (level, low) -> IRQ 18
[10655.544525] uhci_hcd 0000:00:1d.2: setting latency timer to 64
[10655.544553] usb usb7: root hub lost power or was reset
[10655.544568] ehci_hcd 0000:00:1d.7: PCI INT A -> GSI 23 (level, low) -> IRQ 23
[10655.544575] ehci_hcd 0000:00:1d.7: setting latency timer to 64
[10655.544617] pci 0000:00:1e.0: setting latency timer to 64
[10655.544629] ata_piix 0000:00:1f.1: PCI INT A -> GSI 19 (level, low) -> IRQ 19
[10655.544634] ata_piix 0000:00:1f.1: setting latency timer to 64
[10655.544663] ahci 0000:00:1f.2: setting latency timer to 64
[10655.544702] pci 0000:00:1f.3: PCI INT C -> GSI 19 (level, low) -> IRQ 19
[10655.609000] sdhci-pci 0000:07:01.1: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[10655.609015] sdhci-pci 0000:07:01.1: Will use DMA mode even though HW doesn't fully claim to support it.
[10655.610048] sdhci-pci 0000:07:01.2: PCI INT B -> GSI 17 (level, low) -> IRQ 17
[10655.610075] sd 2:0:0:0: [sda] Starting disk
[10655.691296] firewire_core: skipped bus generations, destroying all nodes
[10655.704458] lirc_ite8709 00:02: activated
[10655.910936] ata3: SATA link down (SStatus 0 SControl 300)
[10655.910987] ata2: SATA link down (SStatus 0 SControl 300)
[10656.091024] usb 1-2: reset high speed USB device using ehci_hcd and address 3
[10656.239139] firewire_core: rediscovered device fw0
[10656.297034] rt73usb 1-2:1.0: no reset_resume for driver rt73usb?
[10656.343043] usb 1-1: reset high speed USB device using ehci_hcd and address 5
[10657.009377] ata4.00: ACPI cmd ef/03:0c:00:00:00:a0 (SET FEATURES) filtered out
[10657.009382] ata4.00: ACPI cmd ef/03:42:00:00:00:a0 (SET FEATURES) filtered out
[10657.047254] ata4.00: configured for UDMA/33
[10657.747052] ata1: SATA link up 3.0 Gbps (SStatus 123 SControl 300)
[10657.802687] ata1.00: unexpected _GTF length (8)
[10657.803600] ata1.00: unexpected _GTF length (8)
[10657.803606] ata1.00: configured for UDMA/133
[10657.831994] PM: resume of devices complete after 2288.006 msecs
[10658.094900] ieee80211 phy3: Selected rate control algorithm 'minstrel_ht'
[10658.095158] Registered led device: rt73usb-phy3::radio
[10658.095186] Registered led device: rt73usb-phy3::assoc
[10658.095213] Registered led device: rt73usb-phy3::quality
[10658.096330] Restarting all filesystems ...
[10658.097610] Restarting tasks ... done.
[10658.112141] video LNXVIDEO:00: Restoring backlight state
[10658.626799] ata1.00: configured for UDMA/133
[10658.626802] ata1: EH complete
[10658.626917] sd 2:0:0:0: [sda] Write cache: disabled, read cache: enabled, doesn't support DPO or FUA
[10658.880432] EXT4-fs (sda5): re-mounted. Opts: commit=600
[10658.898346] EXT4-fs (sda6): re-mounted. Opts: commit=600
[10659.029302] sky2 0000:06:00.0: eth0: enabling interface
[10659.029812] ADDRCONF(NETDEV_UP): eth0: link is not ready
[10659.110522] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[10660.278653] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[10660.384415] ADDRCONF(NETDEV_UP): wlan0: link is not ready
[10663.451759] wlan0: authenticate with aa:64:02:41:26:78 (try 1)
[10663.453273] wlan0: authenticated
[10663.474754] wlan0: associate with aa:64:02:41:26:78 (try 1)
[10663.477275] wlan0: RX AssocResp from aa:64:02:41:26:78 (capab=0x411 status=0 aid=1)
[10663.477279] wlan0: associated
[10663.489317] ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
[10674.210014] wlan0: no IPv6 routers present
[10676.906669] wlan0: deauthenticating from aa:64:02:41:26:78 by local choice (reason=3)
[10676.922816] cfg80211: Calling CRDA to update world regulatory domain
[10678.483809] wlan0: authenticate with 92:45:82:b0:f6:9c (try 1)
[10678.497213] wlan0: authenticated
[10678.518695] wlan0: associate with 92:45:82:b0:f6:9c (try 1)
[10678.521092] wlan0: RX AssocResp from 92:45:82:b0:f6:9c (capab=0x411 status=0 aid=1)
[10678.521096] wlan0: associated
[11051.091050] usb 2-4: new high speed USB device using ehci_hcd and address 4
[11051.214066] WARNING! power/level is deprecated; use power/control instead
[11087.097378] gs[7189]: segfault at a845004 ip 081114e8 sp bfc15828 error 6 in gs[8048000+4ca000]
[11985.406984] ACPI: EC: GPE storm detected, transactions will use polling mode
[12030.237212] ata1.00: configured for UDMA/133
[12030.237216] ata1: EH complete
[12030.237325] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[12030.330492] EXT4-fs (sda5): re-mounted. Opts: commit=0
[12030.618297] EXT4-fs (sda6): re-mounted. Opts: commit=0
sabayon toto #

Code: Select all

sabayon toto # lsusb
Bus 002 Device 004: ID 04a9:1709 Canon, Inc. PIXMA MP150 Scanner
Bus 002 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
Bus 006 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 004 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 005 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 003 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 007 Device 001: ID 1d6b:0001 Linux Foundation 1.1 root hub
Bus 001 Device 005: ID 04f2:b024 Chicony Electronics Co., Ltd USB 2.0 Webcam
Bus 001 Device 003: ID 18e8:6229 Qcom RT2573
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub
sabayon toto #

Code: Select all

sabayon toto # ls /etc/udev/rules.d/
10-virtualbox.rules  65-multipath.rules       70-xorg-vboxmouse.rules              77-mm-platform-serial-whitelist.rules  77-mm-zte-port-types.rules  99-fuse.rules
41-libsane.rules     66-kpartx.rules          77-mm-ericsson-mbm.rules             77-mm-simtech-port-types.rules         77-nm-olpc-mesh.rules       99-ntfs3g.rules
65-kvm.rules         70-persistent-cd.rules   77-mm-longcheer-port-types.rules     77-mm-usb-device-blacklist.rules       80-mm-candidate.rules
65-mtp.rules         70-persistent-net.rules  77-mm-pcmcia-device-blacklist.rules  77-mm-x22x-port-types.rules            90-hal.rules
sabayon toto #

Code: Select all

sabayon toto # tail -f /var/log/messages
Mar 24 19:03:50 sabayon kernel: [11985.406984] ACPI: EC: GPE storm detected, transactions will use polling mode
Mar 24 19:04:35 sabayon kernel: [12030.237212] ata1.00: configured for UDMA/133
Mar 24 19:04:35 sabayon kernel: [12030.237216] ata1: EH complete
Mar 24 19:04:35 sabayon kernel: [12030.237325] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
Mar 24 19:04:35 sabayon kernel: [12030.330492] EXT4-fs (sda5): re-mounted. Opts: commit=0
Mar 24 19:04:36 sabayon kernel: [12030.618297] EXT4-fs (sda6): re-mounted. Opts: commit=0
Mar 24 19:10:01 sabayon cron[18973]: (root) CMD (test -x /usr/sbin/run-crons && /usr/sbin/run-crons )
Mar 24 19:20:01 sabayon cron[23071]: (root) CMD (test -x /usr/sbin/run-crons && /usr/sbin/run-crons )
Mar 24 19:30:01 sabayon cron[27113]: (root) CMD (test -x /usr/sbin/run-crons && /usr/sbin/run-crons )
Mar 24 19:40:01 sabayon cron[31124]: (root) CMD (test -x /usr/sbin/run-crons && /usr/sbin/run-crons )
Mar 24 19:45:07 sabayon kernel: [14461.619627] usb 2-4: USB disconnect, address 4
Mar 24 19:45:07 sabayon udev-configure-printer: remove /devices/pci0000:00/0000:00:1d.7/usb2/2-4
Mar 24 19:45:12 sabayon kernel: [14466.854052] usb 2-4: new high speed USB device using ehci_hcd and address 5
Mar 24 19:45:12 sabayon udev-configure-printer: add /devices/pci0000:00/0000:00:1d.7/usb2/2-4/2-4:1.1
Mar 24 19:45:12 sabayon udev-configure-printer: parent devpath is /devices/pci0000:00/0000:00:1d.7/usb2/2-4
Mar 24 19:45:12 sabayon udev-configure-printer: Device vendor/product is 04A9:1709
Mar 24 19:45:12 sabayon udev-configure-printer: MFG:Canon MDL:MP150 SERN:- serial:E21A29
Mar 24 19:45:13 sabayon udev-configure-printer: no corresponding CUPS device found
^C
sabayon toto #

[Fitzcarraldo]

Please use the Code button when you post lengthy output; it save people having to scroll the screen up and down.

Your printer is being recognised as a scanner, that's the problem (probably!). Do the following as root user in a Konsole/Terminal window:

Code: Select all

nano /etc/udev/rules.d/10-usbprinter.rules

Add the following line:

Code: Select all

ATTR{idVendor}=="04a9", ATTR{idProduct}=="1709", MODE:="0660", GROUP:="lp"

Save the file and reboot.

If you want to understand the rationale for the above, see: What to do if CUPS does not recognise MP560 as a printer.

[xenophon2009]

Great it works very well now !!!!

You' re a genius ! Thanks a lot !