Groups | Search | Server Info | Keyboard shortcuts | Login | Register [http] [https] [nntp] [nntps]


Groups > linux.kernel > #1714581 > unrolled thread

32-bit powerpc, aty128fb: vmap allocation for size 135168 failed

Started byMeelis Roos <mroos@linux.ee>
First post2017-08-18 07:40 +0200
Last post2017-08-22 18:40 +0200
Articles 7 — 3 participants

Back to article view | Back to linux.kernel


Contents

  32-bit powerpc, aty128fb: vmap allocation for size 135168 failed Meelis Roos <mroos@linux.ee> - 2017-08-18 07:40 +0200
    Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed Michael Ellerman <mpe@ellerman.id.au> - 2017-08-18 14:30 +0200
      Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168  failed Meelis Roos <mroos@linux.ee> - 2017-08-18 14:30 +0200
      Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168  failed Meelis Roos <mroos@linux.ee> - 2017-08-19 07:40 +0200
        Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed Michael Ellerman <mpe@ellerman.id.au> - 2017-08-22 08:10 +0200
    Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed Andreas Schwab <schwab@linux-m68k.org> - 2017-08-22 18:20 +0200
      Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168  failed Meelis Roos <mroos@linux.ee> - 2017-08-22 18:40 +0200

#1714581 — 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed

FromMeelis Roos <mroos@linux.ee>
Date2017-08-18 07:40 +0200
Subject32-bit powerpc, aty128fb: vmap allocation for size 135168 failed
Message-ID<ufIaJ-7oe-1@gated-at.bofh.it>
I was trying 4.13.0-rc5-00075-gac9a40905a61 on my PowerMac G4 with 1G 
RAM and after some time of sddm respawning and X trying to restart, 
dmesg is full of messages about vmap allocation failures.

Maybe the aty128fb is leaking ROM allocations or something like that?

sddm has been crashing eearlier too but I have not investigated it yet, 
but right after reboot the messages are about ATI ROM contents:

Aug 17 23:53:57 pohl kernel: [ 2940.146546] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1111
Aug 17 23:54:02 pohl kernel: [ 2944.804838] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1110
Aug 17 23:54:06 pohl kernel: [ 2948.992457] sddm[14039]: unhandled signal 11 at 00000030 nip 00000030 lr 0f55f858 code 30001

Then it changes to groups like this:
Aug 17 23:54:29 pohl kernel: [ 2971.514484] sddm[14093]: unhandled signal 11 at 00000090 nip 00000090 lr 0f55f858 code 30001
Aug 17 23:54:30 pohl kernel: [ 2972.994486] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1111
Aug 17 23:54:30 pohl kernel: [ 2973.040595] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
Aug 17 23:54:33 pohl kernel: [ 2976.245220] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1111
Aug 17 23:54:33 pohl kernel: [ 2976.295452] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size

And finally it becomes just vmalloc errors, no ATI ROM messages at all:

[32075.316981] sddm[14563]: unhandled signal 11 at 00000050 nip 00000050 lr 0f55f858 code 30001
[32076.766965] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32076.788476] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32079.124735] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32079.146326] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32081.305352] sddm[14590]: unhandled signal 11 at 00000050 nip 00000050 lr 0f55f858 code 30001
[32082.768060] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32082.789530] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32085.125847] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32085.147228] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32087.311193] sddm[14617]: unhandled signal 11 at 00430068 nip 00430068 lr 0f55f858 code 30001
[32088.767983] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32088.789536] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32091.108732] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32091.130348] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32093.285222] sddm[14644]: unhandled signal 11 at 00000050 nip 00000050 lr 0f55f858 code 30001
[32094.767678] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32094.789329] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32097.128241] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32097.149745] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32099.293082] sddm[14671]: unhandled signal 11 at 00000030 nip 00000030 lr 0f55f858 code 30001
[32100.768030] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32100.789505] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size
[32103.124223] vmap allocation for size 135168 failed: use vmalloc=<size> to increase size
[32103.145881] vmap allocation for size 3149824 failed: use vmalloc=<size> to increase size


# cat /proc/meminfo 
MemTotal:        1031440 kB
MemFree:          135948 kB
MemAvailable:     889288 kB
Buffers:          215448 kB
Cached:           573780 kB
SwapCached:           44 kB
Active:           430480 kB
Inactive:         392416 kB
Active(anon):      14984 kB
Inactive(anon):    92276 kB
Active(file):     415496 kB
Inactive(file):   300140 kB
Unevictable:           0 kB
Mlocked:               0 kB
HighTotal:        262144 kB
HighFree:          22140 kB
LowTotal:         769296 kB
LowFree:          113808 kB
SwapTotal:        848984 kB
SwapFree:         848464 kB
Dirty:               180 kB
Writeback:             0 kB
AnonPages:         33640 kB
Mapped:            84392 kB
Shmem:             73592 kB
Slab:              66972 kB
SReclaimable:      54952 kB
SUnreclaim:        12020 kB
KernelStack:         680 kB
PageTables:         1344 kB
NFS_Unstable:          0 kB
Bounce:                0 kB
WritebackTmp:          0 kB
CommitLimit:     1364704 kB
Committed_AS:     351992 kB
VmallocTotal:     211808 kB
VmallocUsed:           0 kB
VmallocChunk:          0 kB



-- 
Meelis Roos (mroos@linux.ee)

[toc] | [next] | [standalone]


#1714869

FromMichael Ellerman <mpe@ellerman.id.au>
Date2017-08-18 14:30 +0200
Message-ID<ufOzw-3Ek-13@gated-at.bofh.it>
In reply to#1714581
Meelis Roos <mroos@linux.ee> writes:

> I was trying 4.13.0-rc5-00075-gac9a40905a61 on my PowerMac G4 with 1G 
> RAM and after some time of sddm respawning and X trying to restart, 
> dmesg is full of messages about vmap allocation failures.

Did it just start happening? ie. did rc4 work?

cheers

[toc] | [prev] | [next] | [standalone]


#1714871 — Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed

FromMeelis Roos <mroos@linux.ee>
Date2017-08-18 14:30 +0200
SubjectRe: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed
Message-ID<ufOzx-3Ek-23@gated-at.bofh.it>
In reply to#1714869
> > I was trying 4.13.0-rc5-00075-gac9a40905a61 on my PowerMac G4 with 1G 
> > RAM and after some time of sddm respawning and X trying to restart, 
> > dmesg is full of messages about vmap allocation failures.
> 
> Did it just start happening? ie. did rc4 work?

No, rc4 was the first one I tried after 4.12 and it already had the 
problem. Not sure about 4.12 to be honest, will soee some day.

-- 
Meelis Roos (mroos@linux.ee)

[toc] | [prev] | [next] | [standalone]


#1715564 — Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed

FromMeelis Roos <mroos@linux.ee>
Date2017-08-19 07:40 +0200
SubjectRe: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed
Message-ID<ug4Eh-5Fi-1@gated-at.bofh.it>
In reply to#1714869
> Meelis Roos <mroos@linux.ee> writes:
> 
> > I was trying 4.13.0-rc5-00075-gac9a40905a61 on my PowerMac G4 with 1G 
> > RAM and after some time of sddm respawning and X trying to restart, 
> > dmesg is full of messages about vmap allocation failures.
> 
> Did it just start happening? ie. did rc4 work?

It goes back to at least 4.0 - that's the oldest kernel I had laying 
around precompiled. The messages about ROM signature changed somewehere 
between 4.0 and 4.7 (4.7 is already like 4.13) but after some time, the 
same vmalloc errors appear.

Maybe the userspace has changed with more respawning that brings the 
problem out.

I tried to read the code but I do not understand it yet. The warning 
seems to come from generic pci_map_rom() checking ROM size, and 
returning rom pointer to aty128fb (it returns resource size too but that 
is ignored). aty128fb starts to look at the x86 PCI ROM signature again 
but does not tell that the signature is missing. How come?

-- 
Meelis Roos (mroos@linux.ee)

[toc] | [prev] | [next] | [standalone]


#1717050

FromMichael Ellerman <mpe@ellerman.id.au>
Date2017-08-22 08:10 +0200
Message-ID<uhaxX-6Kl-5@gated-at.bofh.it>
In reply to#1715564
Meelis Roos <mroos@linux.ee> writes:

>> Meelis Roos <mroos@linux.ee> writes:
>> 
>> > I was trying 4.13.0-rc5-00075-gac9a40905a61 on my PowerMac G4 with 1G 
>> > RAM and after some time of sddm respawning and X trying to restart, 
>> > dmesg is full of messages about vmap allocation failures.
>> 
>> Did it just start happening? ie. did rc4 work?
>
> It goes back to at least 4.0 - that's the oldest kernel I had laying 
> around precompiled. The messages about ROM signature changed somewehere 
> between 4.0 and 4.7 (4.7 is already like 4.13) but after some time, the 
> same vmalloc errors appear.
>
> Maybe the userspace has changed with more respawning that brings the 
> problem out.
>
> I tried to read the code but I do not understand it yet. The warning 
> seems to come from generic pci_map_rom() checking ROM size, and 
> returning rom pointer to aty128fb (it returns resource size too but that 
> is ignored). aty128fb starts to look at the x86 PCI ROM signature again 
> but does not tell that the signature is missing. How come?

OK thanks. Unfortunately I can't really help on the graphics side of
things. Hopefully someone on Cc has more clues than me.

cheers

[toc] | [prev] | [next] | [standalone]


#1717550

FromAndreas Schwab <schwab@linux-m68k.org>
Date2017-08-22 18:20 +0200
Message-ID<uhk4i-4NV-31@gated-at.bofh.it>
In reply to#1714581
On Aug 18 2017, Meelis Roos <mroos@linux.ee> wrote:

> Aug 17 23:53:57 pohl kernel: [ 2940.146546] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1111
> Aug 17 23:54:02 pohl kernel: [ 2944.804838] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1110

I think these messages are harmless and expected.  This device has no
x86 option ROM but a OpenFirmware one.  This is likely unrelated to the
sddm crash.

Andreas.

-- 
Andreas Schwab, schwab@linux-m68k.org
GPG Key fingerprint = 58CA 54C7 6D53 942B 1756  01D3 44D5 214B 8276 4ED5
"And now for something completely different."

[toc] | [prev] | [next] | [standalone]


#1717563 — Re: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed

FromMeelis Roos <mroos@linux.ee>
Date2017-08-22 18:40 +0200
SubjectRe: 32-bit powerpc, aty128fb: vmap allocation for size 135168 failed
Message-ID<uhknD-4Vd-5@gated-at.bofh.it>
In reply to#1717550
> > Aug 17 23:53:57 pohl kernel: [ 2940.146546] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1111
> > Aug 17 23:54:02 pohl kernel: [ 2944.804838] aty128fb 0000:00:10.0: Invalid PCI ROM header signature: expecting 0xaa55, got 0x1110
> 
> I think these messages are harmless and expected.  This device has no
> x86 option ROM but a OpenFirmware one.  This is likely unrelated to the
> sddm crash.

Yes, but after these crashes have happened for a while, vmalloc 
problems appear.

sddm crash might be related to X server dying under it, or it crashes 
for it own problems (varying signals and addresses beacuse of some 
ASLR?) and causes X server restart that triggers another ROM allocation 
round.

I did read the kernel code and I do not see how the dmesg lines are 
possible without corresponding aty128fb lines about the same ROM 
signature, or why the ROM signature is sometimes 0x1111 and sometimes 
0x1110 instead of x86 ROM signature (that clearly is not there, 
but this is expected).

-- 
Meelis Roos (mroos@linux.ee)

[toc] | [prev] | [standalone]


Back to top | Article view | linux.kernel


csiph-web