ren41
Posts: 99
Joined: Sat May 26, 2012 8:00 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 1:03 pm

Thanks Dom, I'll add that & report back. TBH it is so slow now that if I can't resolve it I'll do a new install, probably later.

ren

xtramural
Posts: 108
Joined: Thu Dec 29, 2011 11:16 pm
Location: Scotland

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 2:58 pm

dom wrote:Currently the sdcard driver busy waits after DMA completes until the card becomes idle before sending a stop signal.

The busy wait delays other interrupts in the system, so could cause interference to other drivers. It could in theory cause audio glitches or USB packet loss.
It also wastes cycles that could be productively spent elsewhere.

Both myself and lb have been running with this the last few weeks with no ill effects. We'd like more people to test it.

I've pushed an update (you can get through rpi-update). It adds a kernel commandline option:
sdhci-bcm2708.sync_after_dma=0

Add that to your cmdline.txt, and report if there's any change in behaviour.
Don't forget to back up, just in case there's any problems.
This update has severely degraded performance on my Kingston 8GB Class 4. Some observations:

Pertinent parts of dmesg output from a recent reboot prior to rpi-update. Boot time (to ssh login)about 43 seconds:

Code: Select all

...
[    0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x2 bcm2708.serial=0x647c6548 smsc95xx.macaddr=B8:27:EB:7C:65:48 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
...
[   24.719324] ### BCM2835 ALSA driver init OK ### 
[   31.406590] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   32.373849] NET: Registered protocol family 10
[   36.015343] Adding 102396k swap on /var/swap.  Priority:-1 extents:2 across:1642492k SS
[   42.698036] eth0: no IPv6 routers present
...
After the latest rpi-update and edit of cmdline.txt to add (at the end of the line) sdhci-bcm2708.sync_after_dma=0:

Code: Select all

[email protected] ~ $ sudo rpi-update 
Raspberry Pi firmware updater by Hexxeh, enhanced by AndrewS
Performing self-update
Autodetecting memory split
Using ARM/GPU memory split of 224MB/32MB
Updating firmware (this will take a few minutes)
Using SoftFP libraries
If no errors appeared, your firmware was successfully updated
A reboot is needed to activate the new firmware
[email protected] ~ $ sudo nano /boot/cmdline.txt 
[...edits to cmdline.txt made and saved]
[email protected] ~ $ sudo shutdown -r now

Broadcast message from [email protected] (pts/0) (Tue Jul 17 13:01:17 2012):
The system is going down for reboot NOW!
[email protected] ~ $ Connection to 192.168.0.10 closed by remote host.
...
[email protected]'s password: 
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.

NOTE: this image is built using Spindle, http://asbradbury.org/projects/spindle
and is a WORK IN PROGRESS. As such, you should expect to need to update to a
new release from raspberrypi.org in the near future. Thank you for your
assistance in testing.

Type 'startx' to launch a graphical session

Last login: Tue Jul 17 11:37:09 2012 from 192.168.0.8
[email protected] ~ $ dmesg
...
[    0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x2 bcm2708.serial=0xf42e715e smsc95xx.macaddr=B8:27:EB:2E:71:5E dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait sdhci-bcm2708.sync_after_dma=0
...
[   44.834935] ### BCM2835 ALSA driver init OK ### 
[   65.246426] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.269874] mmc0: DMA IRQ 6 ignored - results were reset
[   65.288147] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.311472] mmc0: DMA IRQ 6 ignored - results were reset
[   65.339231] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.362818] mmc0: DMA IRQ 6 ignored - results were reset
[   65.382095] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.404411] mmc0: DMA IRQ 6 ignored - results were reset
[   65.420651] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.443434] mmc0: DMA IRQ 6 ignored - results were reset
[   65.465769] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.488733] mmc0: DMA IRQ 6 ignored - results were reset
[   65.505432] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.528190] mmc0: DMA IRQ 6 ignored - results were reset
[   65.544435] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.566031] mmc0: DMA IRQ 6 ignored - results were reset
[   65.583796] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.604664] mmc0: DMA IRQ 6 ignored - results were reset
[   65.619795] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.640187] mmc0: DMA IRQ 6 ignored - results were reset
[   65.659394] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.679506] mmc0: DMA IRQ 6 ignored - results were reset
[   65.694254] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.713959] mmc0: DMA IRQ 6 ignored - results were reset
[   65.737121] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.756260] mmc0: DMA IRQ 6 ignored - results were reset
[   74.844632] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   77.027625] NET: Registered protocol family 10
[   87.111322] eth0: no IPv6 routers present
[  106.404830] Adding 102396k swap on /var/swap.  Priority:-1 extents:2 across:1642492k SS
[email protected] ~ $
[email protected] ~ $ sudo hdparm -tT /dev/mmcblk0

/dev/mmcblk0:
 Timing cached reads:   188 MB in  2.01 seconds =  93.62 MB/sec
 Timing buffered disk reads:  34 MB in  3.13 seconds =  10.88 MB/sec
[email protected] ~ $
So, login time about 2.5x slower :cry: Then, cmdline.txt re-edited to remove the sdhci-bcm2708.sync_after_dma=0 and re-booted:

Code: Select all

...
[    0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x2 bcm2708.serial=0xf42e715e smsc95xx.macaddr=B8:27:EB:2E:71:5E dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
...
[   44.763987] ### BCM2835 ALSA driver init OK ### 
[   64.957178] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   64.980637] mmc0: DMA IRQ 6 ignored - results were reset
[   64.998211] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.021441] mmc0: DMA IRQ 6 ignored - results were reset
[   65.047583] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.071194] mmc0: DMA IRQ 6 ignored - results were reset
[   65.098407] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.120950] mmc0: DMA IRQ 6 ignored - results were reset
[   65.165718] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.188754] mmc0: DMA IRQ 6 ignored - results were reset
[   65.238868] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   65.262180] mmc0: DMA IRQ 6 ignored - results were reset
[   75.762284] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   77.968538] NET: Registered protocol family 10
[   88.990367] eth0: no IPv6 routers present
[  106.438986] Adding 102396k swap on /var/swap.  Priority:-1 extents:2 across:1642492k SS
[email protected] ~ $ more /boot/cmdline.txt 
dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0
p2 rootfstype=ext4 elevator=deadline rootwait
[email protected] ~ $ sudo hdparm -tT /dev/mmcblk0

/dev/mmcblk0:
 Timing cached reads:   162 MB in  2.01 seconds =  80.41 MB/sec
 Timing buffered disk reads:  32 MB in  3.09 seconds =  10.35 MB/sec
[email protected] ~ $ 
HTH to identify that there are still issues with certain cards and the latest firmware updates.

Cheers,

Duncan

lb
Posts: 263
Joined: Sat Jan 28, 2012 8:07 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 3:13 pm

Performance is degraded with *both* sync_after_dma settings and the new firmware? Then there's something else wrong with the update.

dom
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 5424
Joined: Wed Aug 17, 2011 7:41 pm
Location: Cambridge

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 3:15 pm

@duncan
When did you last update? I think the previous kernel is in boot.bak. Can you confirm reverting back to that one increases the speed? Can you also run
uname -a
to identify the age of the previous kernel.

xtramural
Posts: 108
Joined: Thu Dec 29, 2011 11:16 pm
Location: Scotland

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:16 pm

dom wrote:@duncan
When did you last update? I think the previous kernel is in boot.bak. Can you confirm reverting back to that one increases the speed? Can you also run
uname -a
to identify the age of the previous kernel.
Sorry, I'm in the process of re-imaging that card since it was so out of whack. Once I've re-imaged I'll update and try again. It was a card that had a fully updated Wheezy. I now regret not keeping it in it's 'broken' state for further investigation.

kadamski
Posts: 187
Joined: Fri Jun 08, 2012 10:56 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:36 pm

Looking at that kernel patch, it seems that it's enabling SDHCI_QUIRK_MULTIBLOCK_READ_ACMD12 quirk no matter what is sync_after_dma value set to. Maybe this is why performance was degraded also with sync_after_dma turned on?

ren41
Posts: 99
Joined: Sat May 26, 2012 8:00 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:41 pm

I'm sorry if this comes through more than once, I've tried to submit twice and it's not happening fro some reason.

the addition to cmdline.txt increased the speed of the early part of boot but made no difference to the time it took to load xfce, not surprising I suppose as it was working from the USB drive by then.

I forgot to say that since the update on Sunday I have been getting the following statements in the boot sequence -

bcm2708_i2c bcm2708_i2c.0: BCSC 0 controller at 0x20205000 (irq 79)
bcm2708_spi bcm2708_spi.0: SPI controller at 0x20204000 (irq 80)
bcm2708_i2c bcm2708_i2c.1: BCSC 1 controller at 0x20804000 (irq 79)

They are still appearing.

and on typing startx - xauth: (stdin):2: unknown command: "<long hex string>"

and after putting the extra code in cmdline.txt. I got 'waiting for xserver to begin accepting connections'.

thank you

ren

dom
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 5424
Joined: Wed Aug 17, 2011 7:41 pm
Location: Cambridge

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:46 pm

kadamski wrote:Looking at that kernel patch, it seems that it's enabling SDHCI_QUIRK_MULTIBLOCK_READ_ACMD12 quirk no matter what is sync_after_dma value set to. Maybe this is why performance was degraded also with sync_after_dma turned on?
Are you sure? It looks to me like its only adding SDHCI_QUIRK_MULTIBLOCK_READ_ACMD12 when sync_after_dma is false.

dom
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 5424
Joined: Wed Aug 17, 2011 7:41 pm
Location: Cambridge

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:48 pm

ren41 wrote:I forgot to say that since the update on Sunday I have been getting the following statements in the boot sequence -

bcm2708_i2c bcm2708_i2c.0: BCSC 0 controller at 0x20205000 (irq 79)
bcm2708_spi bcm2708_spi.0: SPI controller at 0x20204000 (irq 80)
bcm2708_i2c bcm2708_i2c.1: BCSC 1 controller at 0x20804000 (irq 79)
Yes. That wasn't really wanted. The new image does this:

Code: Select all

cat /etc/modprobe.d/raspi-blacklist.conf
# blacklist spi and i2c by default (many users don't need them)
blacklist spi-bcm2708
blacklist i2c-bcm2708

xtramural
Posts: 108
Joined: Thu Dec 29, 2011 11:16 pm
Location: Scotland

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:53 pm

xtramural wrote:
dom wrote:@duncan
When did you last update? I think the previous kernel is in boot.bak. Can you confirm reverting back to that one increases the speed? Can you also run
uname -a
to identify the age of the previous kernel.
Sorry, I'm in the process of re-imaging that card since it was so out of whack. Once I've re-imaged I'll update and try again. It was a card that had a fully updated Wheezy. I now regret not keeping it in it's 'broken' state for further investigation.
OK, here's the transcript for a recently apt-get upgraded and updated Wheezy install on a Transcend 8GB Class 6 that's never given me any trouble in the past. As you can see after the latest rpi-update the performance degrades badly:

Code: Select all

Last login: Tue Jul 17 14:35:05 on ttys005
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
[email protected]'s password: 
Linux raspberrypi 3.1.9+ #168 PREEMPT Sat Jul 14 18:56:31 BST 2012 armv6l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.

Type 'startx' to launch a graphical session

Last login: Tue Jul 17 17:23:21 2012 from 192.168.0.8
[email protected] ~ $ sudo rpi-update
Raspberry Pi firmware updater by Hexxeh, enhanced by AndrewS
Performing self-update
Autodetecting memory split
Using ARM/GPU memory split of 224MB/32MB
Updating firmware (this will take a few minutes)
Using SoftFP libraries
If no errors appeared, your firmware was successfully updated
A reboot is needed to activate the new firmware
[email protected] ~ $ date
Tue Jul 17 17:29:14 BST 2012
[email protected] ~ $ dmesg | grep mmc
[    0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x2 bcm2708.serial=0xf42e715e smsc95xx.macaddr=B8:27:EB:2E:71:5E dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
[    4.580579] Registered led device: mmc0::
[    4.581078] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
[    4.593257] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
[    4.682282] Waiting for root device /dev/mmcblk0p2...
[    4.730450] mmc0: problem reading SD Status register.
[    4.751620] mmc0: new high speed SDHC card at address b368
[    4.773745] mmcblk0: mmc0:b368 00000 7.51 GiB 
[    4.782767]  mmcblk0: p1 p2
[    4.814640] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[   12.940839] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[email protected] ~ $ dmesg | tail
[   13.302825] Creating card...
[   13.324248] Creating device/chip ..
[   13.330792] Adding controls ..
[   13.348374] Registering card ....
[   13.362391] bcm2835 ALSA CARD CREATED!
[   13.375166] ### BCM2835 ALSA driver init OK ### 
[   19.524905] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   20.588250] NET: Registered protocol family 10
[   24.041328] Adding 102396k swap on /var/swap.  Priority:-1 extents:1 across:102396k SS
[   31.273959] eth0: no IPv6 routers present
[email protected] ~ $ sudo shutdown -r now

Broadcast message from [email protected] (pts/0) (Tue Jul 17 17:30:00 2012):
The system is going down for reboot NOW!
[email protected] ~ $ Connection to 192.168.0.10 closed by remote host.
Connection to 192.168.0.10 closed.
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
[email protected]'s password: 
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.

Type 'startx' to launch a graphical session

Last login: Tue Jul 17 17:25:37 2012 from 192.168.0.8
[email protected] ~ $ date
Tue Jul 17 17:32:21 BST 2012
[email protected] ~ $ dmesg | grep mmc
[    0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x2 bcm2708.serial=0xf42e715e smsc95xx.macaddr=B8:27:EB:2E:71:5E dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
[    4.591745] Registered led device: mmc0::
[    4.592272] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
[    4.604848] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
[    4.700331] Waiting for root device /dev/mmcblk0p2...
[    4.740285] mmc0: new high speed SDHC card at address b368
[    4.757986] mmcblk0: mmc0:b368 00000 7.51 GiB 
[    4.778833]  mmcblk0: p1 p2
[    4.848466] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[   33.988034] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[   56.121401] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   56.144720] mmc0: DMA IRQ 6 ignored - results were reset
[   56.171374] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   56.194720] mmc0: DMA IRQ 6 ignored - results were reset
[   56.226474] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   56.249479] mmc0: DMA IRQ 6 ignored - results were reset
[email protected] ~ $ dmesg | tail
[   56.121401] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   56.144720] mmc0: DMA IRQ 6 ignored - results were reset
[   56.171374] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   56.194720] mmc0: DMA IRQ 6 ignored - results were reset
[   56.226474] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   56.249479] mmc0: DMA IRQ 6 ignored - results were reset
[   66.449446] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   69.255459] NET: Registered protocol family 10
[   80.127540] eth0: no IPv6 routers present
[   96.459190] Adding 102396k swap on /var/swap.  Priority:-1 extents:1 across:102396k SS
[email protected] ~ $ uname -a
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l GNU/Linux
[email protected] ~ $ ls -lisa /boot
total 34556
 1    16 drwxr-xr-x  3 root root    16384 Jan  1  1970 .
 2     4 drwxr-xr-x 23 root root     4096 Jul 13 16:40 ..
17  2008 -rwxr-xr-x  1 root root  2053680 Jul 17 17:26 arm128_start.elf
18  2008 -rwxr-xr-x  1 root root  2053680 Jul 17 17:26 arm192_start.elf
19  2008 -rwxr-xr-x  1 root root  2053680 Jul 17 17:27 arm224_start.elf
20    24 -rwxr-xr-x  1 root root    16536 Jul 17 17:27 bootcode.bin
21     8 -rwxr-xr-x  1 root root      142 Jun 18 00:17 cmdline.txt
22     8 -rwxr-xr-x  1 root root     1179 Jul 13 17:39 config.txt
31     8 -rwxr-xr-x  1 root root       41 Jul 17 17:29 .firmware_revision
28     8 -rwxr-xr-x  1 root root      129 Jun 18 01:30 issue.txt
24  4096 -rwxr-xr-x  1 root root  4189540 Jul 17 17:27 kernel_cutdown.img
25 15944 -rwxr-xr-x  1 root root 16321844 Jul 17 17:28 kernel_emergency.img
23  6120 -rwxr-xr-x  1 root root  6263772 Jul 17 17:28 kernel.img
26   272 -rwxr-xr-x  1 root root   275235 Jul 17 17:27 loader.bin
27  2008 -rwxr-xr-x  1 root root  2053680 Jul 17 17:29 start.elf
30     8 drwxr-xr-x  2 root root     8192 Jul  7 14:52 .Trashes
29     8 -rwxr-xr-x  1 root root     4096 Jul  7 14:52 ._.Trashes
[email protected] ~ $ ls -lsia /boot/.Trashes/
total 24
30  8 drwxr-xr-x 2 root root  8192 Jul  7 14:52 .
 1 16 drwxr-xr-x 3 root root 16384 Jan  1  1970 ..
[email protected] ~ $ sudo nano /boot/cmdline.txt 
[email protected] ~ $ sync
[email protected] ~ $ sync
[email protected] ~ $ date
Tue Jul 17 17:44:13 BST 2012
[email protected] ~ $ sudo shutdown -r now

Broadcast message from [email protected] (pts/0) (Tue Jul 17 17:44:24 2012):
The system is going down for reboot NOW!
[email protected] ~ $ Connection to 192.168.0.10 closed by remote host.
Connection to 192.168.0.10 closed.
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:45:00 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
^C
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:45:11 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
^C
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:45:21 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
^C
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:45:29 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
^C
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:45:40 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
^C
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:45:49 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
^C
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:46:00 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:46:12 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:46:22 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
ssh: connect to host 192.168.0.10 port 22: Connection refused
mac-dunc-2:~ duncan$ date
Tue 17 Jul 2012 17:46:27 BST
mac-dunc-2:~ duncan$ ssh 192.168.0.10 -l pi
[email protected]'s password: 
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l

The programs included with the Debian GNU/Linux system are free software;
the exact distribution terms for each program are described in the
individual files in /usr/share/doc/*/copyright.

Debian GNU/Linux comes with ABSOLUTELY NO WARRANTY, to the extent
permitted by applicable law.

Type 'startx' to launch a graphical session

Last login: Tue Jul 17 17:32:08 2012 from 192.168.0.8
[email protected] ~ $ date
Tue Jul 17 17:46:55 BST 2012
[email protected] ~ $ dmesg | grep mmc
[    0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708.boardrev=0x2 bcm2708.serial=0xf42e715e smsc95xx.macaddr=B8:27:EB:2E:71:5E sdhci-bcm2708.sync_after_dma=0 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
[    4.591436] Registered led device: mmc0::
[    4.591962] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
[    4.604656] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
[    4.695733] Waiting for root device /dev/mmcblk0p2...
[    4.752684] mmc0: new high speed SDHC card at address b368
[    4.770476] mmcblk0: mmc0:b368 00000 7.51 GiB 
[    4.786590]  mmcblk0: p1 p2
[    4.838689] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[   34.920931] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[   57.282039] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.305465] mmc0: DMA IRQ 6 ignored - results were reset
[   57.323440] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.346849] mmc0: DMA IRQ 6 ignored - results were reset
[   57.372030] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.395591] mmc0: DMA IRQ 6 ignored - results were reset
[   57.416629] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.439346] mmc0: DMA IRQ 6 ignored - results were reset
[   57.466003] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.488773] mmc0: DMA IRQ 6 ignored - results were reset
[   57.507183] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.529975] mmc0: DMA IRQ 6 ignored - results were reset
[email protected] ~ $ dmesg | tail
[   57.416629] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.439346] mmc0: DMA IRQ 6 ignored - results were reset
[   57.466003] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.488773] mmc0: DMA IRQ 6 ignored - results were reset
[   57.507183] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[   57.529975] mmc0: DMA IRQ 6 ignored - results were reset
[   67.575512] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[   70.363707] NET: Registered protocol family 10
[   80.489868] eth0: no IPv6 routers present
[   97.469706] Adding 102396k swap on /var/swap.  Priority:-1 extents:1 across:102396k SS
[email protected]

ren41
Posts: 99
Joined: Sat May 26, 2012 8:00 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 4:54 pm

It's still putting those lines in, dom, even with the extra line added to cmdline.txt (I'll just boot it up again to be sure, now I've said that).

ren

ren41
Posts: 99
Joined: Sat May 26, 2012 8:00 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 5:00 pm

yes, they are still there.

ren

User avatar
ukscone
Forum Moderator
Forum Moderator
Posts: 4203
Joined: Fri Jul 29, 2011 2:51 pm
Contact: Website

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 5:00 pm

i just made a new sd card (wheezy-raspbian) using a sandisk 16gig class 10 card and it's a lot slower than the class 6 8gig one i was using yesterday, almost unusable, not 100% if it was slow on first boot and i had updated immediately

i'm using [email protected] ~ $ uname -a
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l GNU/Linux



[email protected] ~ $ /opt/vc/bin/vcgencmd version
Jul 17 2012 01:21:26
Copyright (c) 2012 Broadcom
version 325699 (release)


i'll try sdhci-bcm2708.sync_after_dma=0 in cmdline.txt & see what happens & a roll back of kernel & firmware & see what happens

ren41
Posts: 99
Joined: Sat May 26, 2012 8:00 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 5:10 pm

Mine is the same as xtramural's - 3.1.9+ #168 - but it's Squeeze.

I think my Wheezy one is now 3.1.9+ #162; I managed to 'downgrade' it by forcing sudo apt-get update && sudo apt-get upgrade. I had put it to #168 and that was very slow, #162 seems faster.

ren

User avatar
ukscone
Forum Moderator
Forum Moderator
Posts: 4203
Joined: Fri Jul 29, 2011 2:51 pm
Contact: Website

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 5:30 pm

rolling back to


[email protected] $ uname -a
Linux raspberrypi 3.1.9+ #168 PREEMPT Sat Jul 14 18:56:31 BST 2012 armv6l GNU/Linux
[email protected] $ /opt/vc/bin/vcgencmd version
Jul 14 2012 13:11:40
Copyright (c) 2012 Broadcom
version 325444 (release)

and it's better, feels about the same as the 8gig class 6 card i was using yesterday

dom
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 5424
Joined: Wed Aug 17, 2011 7:41 pm
Location: Cambridge

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 5:37 pm

@ukscone. Can you update everything, then downgrade kernel to the 14th? (i.e. with latest start.elf) and report?

User avatar
ukscone
Forum Moderator
Forum Moderator
Posts: 4203
Joined: Fri Jul 29, 2011 2:51 pm
Contact: Website

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 6:13 pm

sloooooooooooooooooooooooooooow. a snail ran across my screen in the time it took to boot :)

[email protected] ~ $ uname -a
Linux raspberrypi 3.1.9+ #168 PREEMPT Sat Jul 14 18:56:31 BST 2012 armv6l GNU/Linux
[email protected] ~ $ /opt/vc/bin/vcgencmd version
Jul 17 2012 01:21:26
Copyright (c) 2012 Broadcom
version 325699 (release)


[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Linux version 3.1.9+ ([email protected]) (gcc version 4.5.1 (Broadcom-2708) ) #168 PREEMPT Sat Jul 14 18:56:31 BST 2012
[ 0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
[ 0.000000] CPU: VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
[ 0.000000] Machine: BCM2708
[ 0.000000] Memory policy: ECC disabled, Data cache writeback
[ 0.000000] On node 0 totalpages: 57344
[ 0.000000] free_area_init_node: node 0, pgdat c05f7c4c, node_mem_map c06c8000
[ 0.000000] Normal zone: 448 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 56896 pages, LIFO batch:15
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 56896
[ 0.000000] Kernel command line: dma.dmachans=0x3c bcm2708_fb.fbwidth=720 bcm2708_fb.fbheight=480 bcm2708.boardrev=0x2 bcm2708.serial=0x24355b85 smsc95xx.macaddr=B8:27:EB:35:5B:85 dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
[ 0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
[ 0.000000] Memory: 224MB = 224MB total
[ 0.000000] Memory: 220392k/220392k available, 8984k reserved, 0K highmem
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xfff00000 - 0xfffe0000 ( 896 kB)
[ 0.000000] DMA : 0xffc00000 - 0xffe00000 ( 2 MB)
[ 0.000000] vmalloc : 0xce800000 - 0xd8000000 ( 152 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xce000000 ( 224 MB)
[ 0.000000] modules : 0xbf000000 - 0xc0000000 ( 16 MB)
[ 0.000000] .text : 0xc0008000 - 0xc05943d0 (5681 kB)
[ 0.000000] .init : 0xc0595000 - 0xc05c7000 ( 200 kB)
[ 0.000000] .data : 0xc05c8000 - 0xc05f93b8 ( 197 kB)
[ 0.000000] .bss : 0xc05f93dc - 0xc06c7504 ( 825 kB)
[ 0.000000] NR_IRQS:245
[ 0.000000] timer_set_mode: unhandled mode:1
[ 0.000000] timer_set_mode: unhandled mode:3
[ 0.000000] Console: colour dummy device 80x30
[ 0.000000] console [tty1] enabled
[ 2.961155] Calibrating delay loop... 697.95 BogoMIPS (lpj=3489792)
[ 3.020108] pid_max: default: 32768 minimum: 301
[ 3.020741] Mount-cache hash table entries: 512
[ 3.021403] Initializing cgroup subsys cpuacct

[ 3.021520] Initializing cgroup subsys devices
[ 3.021571] Initializing cgroup subsys freezer
[ 3.021614] Initializing cgroup subsys blkio
[ 3.021733] CPU: Testing write buffer coherency: ok
[ 3.021869] ftrace: allocating 14801 entries in 44 pages
[ 3.096968] hw perfevents: enabled with v6 PMU driver, 3 counters available
[ 3.099003] devtmpfs: initialized
[ 3.106959] NET: Registered protocol family 16
[ 3.108929] vc-mem: mm_vc_mem_phys_addr = 0x00000000
[ 3.108997] vc-mem: mm_vc_mem_size = 0x10000000 (256 MiB)
[ 3.109536] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
[ 3.109609] hw-breakpoint: maximum watchpoint size is 4 bytes.
[ 3.109659] mailbox: Broadcom VideoCore Mailbox driver
[ 3.109773] bcm2708_vcio: mailbox at f200b880
[ 3.109883] bcm_power: Broadcom power driver
[ 3.109931] bcm_power_open() -> 0
[ 3.109963] bcm_power_request(0, 8)
[ 3.610666] bcm_mailbox_read -> 00000080, 0
[ 3.610713] bcm_power_request -> 0
[ 3.610746] Serial: AMBA PL011 UART driver
[ 3.610940] dev:f1: ttyAMA0 at MMIO 0x20201000 (irq = 83) is a PL011 rev3
[ 3.916655] console [ttyAMA0] enabled
[ 3.942866] bio: create slab <bio-0> at 0
[ 3.948486] SCSI subsystem initialized
[ 3.952548] usbcore: registered new interface driver usbfs
[ 3.958360] usbcore: registered new interface driver hub
[ 3.964009] usbcore: registered new device driver usb
[ 3.970205] Switching to clocksource stc
[ 3.979230] Switched to NOHz mode on CPU #0
[ 3.993303] FS-Cache: Loaded
[ 3.996720] CacheFiles: Loaded
[ 4.019272] NET: Registered protocol family 2
[ 4.024332] IP route cache hash table entries: 2048 (order: 1, 8192 bytes)
[ 4.032862] TCP established hash table entries: 8192 (order: 4, 65536 bytes)
[ 4.040424] TCP bind hash table entries: 8192 (order: 3, 32768 bytes)
[ 4.047146] TCP: Hash tables configured (established 8192 bind 8192)
[ 4.053532] TCP reno registered
[ 4.056749] UDP hash table entries: 256 (order: 0, 4096 bytes)
[ 4.062640] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
[ 4.069528] NET: Registered protocol family 1
[ 4.075017] RPC: Registered named UNIX socket transport module.
[ 4.080992] RPC: Registered udp transport module.

[ 4.085943] RPC: Registered tcp transport module.
[ 4.090681] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 4.097555] bcm2708_dma: DMA manager at ce808000
[ 4.102334] bcm2708_gpio: bcm2708_gpio_probe c05d00e0
[ 4.108028] vc-mem: Videocore memory driver
[ 4.113174] audit: initializing netlink socket (disabled)
[ 4.118752] type=2000 audit(0.780:1): initialized
[ 4.234103] VFS: Disk quotas dquot_6.5.2
[ 4.238454] Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
[ 4.246479] FS-Cache: Netfs 'nfs' registered for caching
[ 4.253201] msgmni has been set to 430
[ 4.259930] io scheduler noop registered
[ 4.263913] io scheduler deadline registered (default)
[ 4.269503] io scheduler cfq registered
[ 4.273679] BCM2708FB: registering framebuffer ([email protected])
[ 4.280118] bcm2708_fb_set_par info(cd8ec400) 720x480 (720x480), 0, 16
[ 4.283240] BCM2708FB: start = ce900000,4f385000 width=720, height=480, bpp=16, pitch=1440 size=691200 success=0
[ 4.288823] Console: switching to colour frame buffer device 90x30
[ 4.327799] BCM2708FB: register framebuffer (0)
[ 4.336171] kgdb: Registered I/O driver kgdboc.
[ 4.356692] brd: module loaded
[ 4.369570] loop: module loaded
[ 4.376780] vcos: [1]: vchiq_init_state: slot_zero = 0xffd80000, is_master = 0
[ 4.387339] vcos: [1]: vchiq_init_state: called
[ 4.396137] vcos: [1]: vchiq: initialised - version 2 (min 2), device 253.0
[ 4.407162] usbcore: registered new interface driver smsc95xx
[ 4.416115] cdc_ncm: 04-Aug-2011
[ 4.422511] usbcore: registered new interface driver cdc_ncm
[ 4.431326] dwc_otg: version 2.90b 6-MAY-2010 (platform bus)
[ 4.440560] Core Release: 2.80a
[ 4.446875] Setting default values for core params
[ 4.454798] Finished setting default values for core params
[ 4.463683] ce840008 -> 1
[ 4.669392] Using Buffer DMA mode
[ 4.675850] Periodic Transfer Interrupt Enhancement - disabled
[ 4.684811] Multiprocessor Interrupt Enhancement - disabled
[ 4.693552] dwc_otg bcm2708_usb: DWC OTG Controller
[ 4.701723] dwc_otg bcm2708_usb: new USB bus registered, assigned bus number 1
[ 4.712305] dwc_otg bcm2708_usb: irq 75, io mem 0x00000000
[ 4.721034] Init: Port Power? op_state=1
[ 4.728075] Init: Power Port (0)
[ 4.734456] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002

[ 4.744196] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 4.754442] usb usb1: Product: DWC OTG Controller
[ 4.762067] usb usb1: Manufacturer: Linux 3.1.9+ dwc_otg_hcd
[ 4.770752] usb usb1: SerialNumber: bcm2708_usb
[ 4.779571] hub 1-0:1.0: USB hub found
[ 4.786457] hub 1-0:1.0: 1 port detected
[ 4.794113] Module dwc_common_port init
[ 4.794667] usbcore: registered new interface driver uas
[ 4.802831] Initializing USB Mass Storage driver...
[ 4.810993] usbcore: registered new interface driver usb-storage
[ 4.819960] USB Mass Storage support registered.
[ 4.827823] usbcore: registered new interface driver libusual
[ 4.837051] mousedev: PS/2 mouse device common for all mice
[ 4.845619] cpuidle: using governor ladder
[ 4.852495] cpuidle: using governor menu
[ 4.859396] sdhci: Secure Digital Host Controller Interface driver
[ 4.868448] sdhci: Copyright(c) Pierre Ossman
[ 4.876002] bcm_power_open() -> 1
[ 4.882388] Registered led device: mmc0::
[ 4.882947] mmc0: SDHCI controller on BCM2708_Arasan [platform] using platform's DMA
[ 4.894013] mmc0: BCM2708 SDHC host at 0x20300000 DMA 2 IRQ 77
[ 4.902933] sdhci-pltfm: SDHCI platform and OF driver helper
[ 4.912971] Registered led device: led0
[ 4.913489] usbcore: registered new interface driver usbhid
[ 4.922027] usbhid: USB HID core driver
[ 4.938022] TCP cubic registered
[ 4.944078] Initializing XFRM netlink socket
[ 4.951375] NET: Registered protocol family 17
[ 4.960885] Registering the dns_resolver key type
[ 4.970610] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
[ 4.996575] Waiting for root device /dev/mmcblk0p2...
[ 5.041220] mmc0: new high speed SDHC card at address e624
[ 5.065092] mmcblk0: mmc0:e624 SU16G 14.8 GiB
[ 5.075647] mmcblk0: p1 p2
[ 5.141514] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
[ 5.156089] VFS: Mounted root (ext4 filesystem) on device 179:2.
[ 5.166985] Freeing init memory: 200K
[ 5.214458] usb 1-1: new high speed USB device number 2 using dwc_otg
[ 5.445048] usb 1-1: New USB device found, idVendor=0424, idProduct=9512
[ 5.455662] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 5.471444] hub 1-1:1.0: USB hub found
[ 5.481692] hub 1-1:1.0: 3 ports detected

[ 5.764672] usb 1-1.1: new high speed USB device number 3 using dwc_otg
[ 5.895190] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
[ 5.910811] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
[ 5.927433] smsc95xx v1.0.4
[ 6.003911] smsc95xx 1-1.1:1.0: eth0: register 'smsc95xx' at usb-bcm2708_usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:35:5b:85
[ 40.858333] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
[ 43.372133] ### snd_bcm2835_alsa_probe c05d07a0 ############### PROBING FOR bcm2835 ALSA device (0):(1) ###############
[ 43.424058] Creating card...
[ 43.441024] Creating device/chip ..
[ 43.464089] Adding controls ..
[ 43.500326] Registering card ....
[ 43.542335] bcm2835 ALSA CARD CREATED!
[ 43.578608] ### BCM2835 ALSA driver init OK ###
[ 73.340119] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.371324] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.391861] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.411066] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.433538] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.452349] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.470707] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.489320] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.512387] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.530604] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.554001] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.571649] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.589874] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.606992] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.627611] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.644383] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.667856] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.684786] mmc0: DMA IRQ 6 ignored - results were reset
[ 73.707786] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 73.725090] mmc0: DMA IRQ 6 ignored - results were reset
[ 88.203691] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[ 126.415389] Adding 102396k swap on /var/swap. Priority:-1 extents:1 across:102396k SS

dom
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 5424
Joined: Wed Aug 17, 2011 7:41 pm
Location: Cambridge

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 6:29 pm

ukscone wrote:sloooooooooooooooooooooooooooow. a snail ran across my screen in the time it took to boot :)
So just to be competely clear, latest everything, and downgrade start.elf one version, is it fast?

User avatar
ukscone
Forum Moderator
Forum Moderator
Posts: 4203
Joined: Fri Jul 29, 2011 2:51 pm
Contact: Website

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 6:34 pm

let me redo it again as i might have screwed up.

i rpi-update which will give me today's updates then overwrite start.elf with the 1 from the 14th?

iirc i updated everything and overwrite kernel.img with the 1 from the 14th

User avatar
ukscone
Forum Moderator
Forum Moderator
Posts: 4203
Joined: Fri Jul 29, 2011 2:51 pm
Contact: Website

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 6:41 pm

[email protected] ~ $ /opt/vc/bin/vcgencmd version
Jul 14 2012 13:14:43
Copyright (c) 2012 Broadcom
version 325444 (release)
[email protected] ~ $ uname -a
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l GNU/Linux


about back to the speed i had with the class 6 card yesterday. only took a minute or so from reboot to be able too ssh in rather than the 5 minutes it was taking to let me in with start.elf from today

kadamski
Posts: 187
Joined: Fri Jun 08, 2012 10:56 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 7:22 pm

dom wrote: Are you sure? It looks to me like its only adding SDHCI_QUIRK_MULTIBLOCK_READ_ACMD12 when sync_after_dma is false.
Ahh, you're right. I'm an idiot.

dom
Raspberry Pi Engineer & Forum Moderator
Raspberry Pi Engineer & Forum Moderator
Posts: 5424
Joined: Wed Aug 17, 2011 7:41 pm
Location: Cambridge

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 8:48 pm

ukscone wrote: about back to the speed i had with the class 6 card yesterday. only took a minute or so from reboot to be able too ssh in rather than the 5 minutes it was taking to let me in with start.elf from today
So latest start.elf makes bootup slow. That is surprising. Anyone else get the same behaviour?

User avatar
ukscone
Forum Moderator
Forum Moderator
Posts: 4203
Joined: Fri Jul 29, 2011 2:51 pm
Contact: Website

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 9:22 pm

just went through to confirm it

with the latest fw/kernel it's painfully slow, 5 mins to be able to ssh in after reboot

[code][ 39.272145] ### BCM2835 ALSA driver init OK ###
[ 66.310798] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.341838] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.369250] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.388743] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.408114] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.427048] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.467377] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.486008] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.510213] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.528601] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.548458] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.566580] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.583966] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.601535] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.620275] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.637507] mmc0: DMA IRQ 6 ignored - results were reset
[ 66.657221] mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
[ 66.674440] mmc0: DMA IRQ 6 ignored - results were reset
[ 79.580196] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[ 115.266179] Adding 102396k swap on /var/swap. Priority:-1 extents:1 across:102396k SS
[email protected] ~ $ uname -a
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l GNU/Linux
[email protected] ~ $ /opt/vc/bin/vcgencmd version
Jul 17 2012 01:21:26
Copyright (c) 2012 Broadcom
version 325699 (release)
[email protected] ~ $ cat /boot/cmdline.txt
dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait sdhci-bcm2708.sync_after_dma=0
[email protected] ~ $
[/code]

use start.elf from the 14th, it basically as fast as it was previously
[code][ 12.815027] ### snd_bcm2835_alsa_probe c05d07a0 ############### PROBING FOR bcm2835 ALSA device (0):(1) ###############
[ 12.831904] Creating card...
[ 12.837957] Creating device/chip ..
[ 12.844909] Adding controls ..
[ 12.850910] Registering card ....
[ 12.866146] bcm2835 ALSA CARD CREATED!
[ 12.873703] ### BCM2835 ALSA driver init OK ###
[ 19.924691] smsc95xx 1-1.1:1.0: eth0: link up, 100Mbps, full-duplex, lpa 0x45E1
[ 23.290888] Adding 102396k swap on /var/swap. Priority:-1 extents:1 across:102396k SS
[email protected] ~ $ uname -a
Linux raspberrypi 3.1.9+ #171 PREEMPT Tue Jul 17 01:08:22 BST 2012 armv6l GNU/Linux
[email protected] ~ $ /opt/vc/bin/vcgencmd version
Jul 14 2012 13:14:43
Copyright (c) 2012 Broadcom
version 325444 (release)
[email protected] ~ $ cat /boot/cmdline.txt
dwc_otg.lpm_enable=0 console=ttyAMA0,115200 kgdboc=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline rootwait
[email protected] ~ $
[/code]

ren41
Posts: 99
Joined: Sat May 26, 2012 8:00 pm

Re: SD Card performance in R-Pi onboard slot

Tue Jul 17, 2012 9:59 pm

if #171 is basically #168 plus your extra line in cmdline.txt then yes, that's what I'm running and it is very slow. Barring some illumination on what's happening, then if I get time tomorrow I'll do a new install of the Squeeze distro, update it (rpi-update, apt-get update/upgrade, or both?) and see where I am then, so I can post back.

Hopefully at least I'll get a proper Scratch install this time if I start again from....scratch (!).

ren

Ben23
Posts: 11
Joined: Wed Jul 18, 2012 12:33 am

Re: SD Card performance in R-Pi onboard slot

Wed Jul 18, 2012 12:53 am

Hi, I've only had my RPi a couple of days and been experimenting with different SD cards and different distros. I too have found that wheezy with the latest start.elf is extremely slow to boot on a Sandisk 4GB class 6 card (labelled 30MB/s). It's taking 105s to get to enabling the swapfile. There are also lots of these errors:

Code: Select all

mmc0: missed completion of cmd 17 DMA (512/512 [1]/[1]) - ignoring it
mmc0: DMA IRQ 6 ignored - results were reset
which occur in batches any time during and/or after boot. Running things like dpkg-reconfigure locales or keyboard-configuration takes several minutes. Even starting the shell on login is slow. For contiguous file reads and writes, dd generally reports about 10MB/s, but it seems random access speed has dropped right off.

I'm using the latest start.elf because the one that came with the wheezy beta hangs at the logo (I'm on a composite display if that makes any difference).

I've tried both the kernel that came with the beta (#125) and the latest (#171) with the same outcome (the latter both with and without the extra cmdline.txt parameter)

Going to try it on a class 4 card now and see what happens.

Return to “General discussion”