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


Groups > linux.debian.bugs.dist > #730256 > unrolled thread

Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

Started byVagrant Cascadian <vagrant@debian.org>
First post2016-04-10 20:20 +0200
Last post2016-04-11 15:10 +0200
Articles 20 — 4 participants

Back to article view | Back to linux.debian.bugs.dist


Contents

  Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-04-10 20:20 +0200
    Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-04-10 21:20 +0200
      Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-04-10 22:30 +0200
      Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Diederik de Haas <didi.debian@cknow.org> - 2016-04-10 23:00 +0200
        Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-04-11 02:20 +0200
          Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-04-11 03:10 +0200
            Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-04-11 17:20 +0200
            Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-04-13 20:50 +0200
              Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-04-28 17:20 +0200
                Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Diederik de Haas <didi.debian@cknow.org> - 2016-04-28 17:40 +0200
                  Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-04-28 18:20 +0200
                Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-05-02 03:30 +0200
                  Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-05-02 21:00 +0200
                    Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-05-03 06:10 +0200
                      Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Vagrant Cascadian <vagrant@debian.org> - 2016-05-03 18:20 +0200
                        Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-05-07 13:50 +0200
                          Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2:  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Diederik de Haas <didi.debian@cknow.org> - 2016-05-07 14:10 +0200
    Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Bjørn Mork <bjorn@mork.no> - 2016-04-11 10:20 +0200
      Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Ben Hutchings <ben@decadent.org.uk> - 2016-04-11 13:30 +0200
        Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped Bjørn Mork <bjorn@mork.no> - 2016-04-11 15:10 +0200

#730256 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-04-10 20:20 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rms7M-CA-13@gated-at.bofh.it>

[Multipart message — attachments visible in raw view] — view raw

Package: src:linux
Version: 4.5-1~exp1
Severity: normal

Thanks for enabling support for raspberry pi 2!

It works for the most part, but floods syslog with messages:

[501966.870273] net_ratelimit: 35702 callbacks suppressed
[501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

It seems to function ok, though I'm not sure if there's degraded
network performance...

Not sure if the version of the boot firmware and/or u-boot would likely
impact this, or running stretch/sid vs. jessie.

I also experience this on a second rpi2, similarly configured.


live well,
  vagrant


-- Package-specific info:
** Version:
Linux version 4.5.0-trunk-armmp-lpae (debian-kernel@lists.debian.org) (gcc version 5.3.1 20160316 (Debian 5.3.1-12) ) #1 SMP Debian 4.5-1~exp1 (2016-03-20)

** Command line:
root=/dev/mapper/rpi2b-root console=ttyAMA0,115200

** Not tainted

** Kernel log:
[496926.383178] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.390069] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.397026] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.405843] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.412441] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.419085] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.425923] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.433675] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.440371] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496926.447153] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496931.412674] net_ratelimit: 6206 callbacks suppressed
[496931.417762] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.093933] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.108465] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.164059] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.208265] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.226975] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.246691] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.265630] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.287754] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[496932.294860] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.490001] net_ratelimit: 285 callbacks suppressed
[497554.495003] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.501775] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.510097] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.516646] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.523284] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.531653] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.538317] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.545981] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.554849] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[497554.561473] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498179.500059] net_ratelimit: 5196 callbacks suppressed
[498179.505139] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498190.972627] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498192.138691] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.264114] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.270634] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.278020] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.284598] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.291305] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.298322] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.305610] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498193.312196] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498667.628700] net_ratelimit: 6384 callbacks suppressed
[498667.633789] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.372264] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.379072] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.385927] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.392619] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.399375] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.406110] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.412718] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.419497] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.426310] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[498741.433143] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.624239] net_ratelimit: 2507 callbacks suppressed
[501393.629322] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.637072] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.643651] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.651078] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.657591] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.665334] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.672395] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.680122] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.686796] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501393.693360] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.653810] net_ratelimit: 8090 callbacks suppressed
[501398.658895] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.712739] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.768378] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.785975] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.803592] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.821153] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.832670] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.843861] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.867621] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501398.891856] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.019931] net_ratelimit: 53262 callbacks suppressed
[501810.025102] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.031966] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.038983] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.047132] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.053994] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.060761] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.067329] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.074002] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.080625] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501810.087385] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.870273] net_ratelimit: 35702 callbacks suppressed
[501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.882359] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.889364] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.896346] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.903373] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.915138] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.921710] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.928236] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.934854] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
[501966.941474] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

** Model information
Hardware	: BCM2835
Revision	: 0000
Device Tree model: Raspberry Pi 2 Model B

** Loaded modules:
cpufreq_userspace
cpufreq_ondemand
cpufreq_stats
cpufreq_powersave
cpufreq_conservative
nf_conntrack_ipv4
nf_defrag_ipv4
iptable_filter
ip_tables
xt_tcpudp
nf_conntrack_ipv6
nf_defrag_ipv6
xt_conntrack
nf_conntrack
ip6table_filter
ip6_tables
x_tables
smsc95xx
usbnet
mii
i2c_bcm2835
leds_gpio
bcm2835_rng
rng_core
bcm2835_wdt
autofs4
ext4
crc16
mbcache
jbd2
sg
sd_mod
uas
usb_storage
scsi_mod
dm_mod
sdhci_bcm2835
sdhci_pltfm
dwc2
udc_core
usbcore
usb_common
sdhci

** Network interface configuration:
source-directory /etc/network/interfaces.d

** Network status:
*** IP interfaces and addresses:
1: lo: <LOOPBACK,UP,LOWER_UP> mtu 65536 qdisc noqueue state UNKNOWN group default qlen 1
    link/loopback 00:00:00:00:00:00 brd 00:00:00:00:00:00
    inet 127.0.0.1/8 scope host lo
       valid_lft forever preferred_lft forever
    inet6 ::1/128 scope host 
       valid_lft forever preferred_lft forever
2: eth0: <BROADCAST,MULTICAST,UP,LOWER_UP> mtu 1500 qdisc pfifo_fast state UP group default qlen 1000
    link/ether fc:05:ec:e2:44:86 brd ff:ff:ff:ff:ff:ff
    inet 10.0.0.35/24 brd 10.0.0.255 scope global eth0
       valid_lft forever preferred_lft forever
    inet6 fe80::fe05:ecff:fee2:4486/64 scope link 
       valid_lft forever preferred_lft forever

*** Device statistics:
Inter-|   Receive                                                |  Transmit
 face |bytes    packets errs drop fifo frame compressed multicast|bytes    packets errs drop fifo colls carrier compressed
    lo: 99348931 1408310    0    0    0     0          0         0 99348931 1408310    0    0    0     0       0          0
  eth0: 2545424168 18371172    0    0    0     0          0         0 3396891651 5215509    0    0    0     0       0          0

*** Protocol statistics:
Ip:
    19707597 total packets received
    52 with invalid addresses
    0 forwarded
    0 incoming packets discarded
    19707390 incoming packets delivered
    6610433 requests sent out
    40 dropped because of missing route
    14 fragments failed
Icmp:
    2077 ICMP messages received
    0 input ICMP message failed.
    ICMP input histogram:
        destination unreachable: 1554
        echo requests: 523
    537 ICMP messages sent
    0 ICMP messages failed
    ICMP output histogram:
        destination unreachable: 14
        echo replies: 523
IcmpMsg:
        InType3: 1554
        InType8: 523
        OutType0: 523
        OutType3: 14
Tcp:
    12258 active connections openings
    4968 passive connection openings
    1 failed connection attempts
    0 connection resets received
    9 connections established
    19648887 segments received
    6512189 segments send out
    43150 segments retransmited
    0 bad segments received.
    8 resets sent
Udp:
    56425 packets received
    0 packets to unknown port received.
    0 packet receive errors
    54560 packets sent
UdpLite:
TcpExt:
    2 invalid SYN cookies received
    7357 TCP sockets finished time wait in fast timer
    15016 delayed acks sent
    437 delayed acks further delayed because of locked socket
    Quick ack mode was activated 555 times
    52422 packets directly queued to recvmsg prequeue.
    176682105 bytes directly in process context from backlog
    1217932 bytes directly received in process context from prequeue
    16411419 packet headers predicted
    183207 packets header predicted and directly queued to user
    258920 acknowledgments not containing data payload received
    2509378 predicted acknowledgments
    1919 times recovered from packet loss by selective acknowledgements
    Detected reordering 6 times using SACK
    Detected reordering 5 times using time stamp
    7 congestion windows fully recovered without slow start
    9 congestion windows partially recovered using Hoe heuristic
    179 congestion windows recovered without slow start by DSACK
    558 congestion windows recovered without slow start after partial ack
    TCPLostRetransmit: 97
    757 timeouts after SACK recovery
    5 timeouts in loss state
    18463 fast retransmits
    59 forward retransmits
    3151 retransmits in slow start
    4939 other TCP timeouts
    TCPLossProbes: 1179
    TCPLossProbeRecovery: 335
    4 SACK retransmits failed
    555 DSACKs sent for old packets
    525 DSACKs received
    141 DSACKs for out of order packets received
    3 connections reset due to unexpected data
    TCPDSACKIgnoredNoUndo: 152
    TCPSpuriousRTOs: 529
    TCPSackShiftFallback: 142766
    TCPRcvCoalesce: 494293
    TCPOFOQueue: 251
    TCPSpuriousRtxHostQueues: 11
    TCPAutoCorking: 96050
    TCPFromZeroWindowAdv: 4331
    TCPToZeroWindowAdv: 4331
    TCPWantZeroWindowAdv: 12725
    TCPSynRetrans: 19551
    TCPOrigDataSent: 4015474
    TCPHystartTrainDetect: 1
    TCPHystartTrainCwnd: 18
    TCPHystartDelayDetect: 234
    TCPHystartDelayCwnd: 10074
    TCPACKSkippedSeq: 14
IpExt:
    InMcastPkts: 1915
    OutMcastPkts: 32
    InBcastPkts: 149
    InOctets: 24116145632
    OutOctets: 3360336012
    InMcastOctets: 280513
    OutMcastOctets: 4044
    InBcastOctets: 43555
    InNoECTPkts: 19707597


** PCI devices:

** USB devices:
Bus 001 Device 004: ID 174c:55aa ASMedia Technology Inc. ASMedia 2105 SATA bridge
Bus 001 Device 003: ID 0424:ec00 Standard Microsystems Corp. SMSC9512/9514 Fast Ethernet Adapter
Bus 001 Device 002: ID 0424:9514 Standard Microsystems Corp. 
Bus 001 Device 001: ID 1d6b:0002 Linux Foundation 2.0 root hub


-- System Information:
Debian Release: 8.4
  APT prefers stable-updates
  APT policy: (500, 'stable-updates'), (500, 'stable'), (1, 'experimental'), (1, 'unstable')
Architecture: armhf (armv7l)

Kernel: Linux 4.5.0-trunk-armmp-lpae (SMP w/4 CPU cores)
Locale: LANG=en_US.utf8, LC_CTYPE=en_US.utf8 (charmap=UTF-8)
Shell: /bin/sh linked to /bin/dash
Init: systemd (via /run/systemd/system)

Versions of packages linux-image-4.5.0-trunk-armmp-lpae depends on:
ii  debconf [debconf-2.0]                   1.5.56
ii  initramfs-tools [linux-initramfs-tool]  0.120+deb8u1
ii  kmod                                    18-3
ii  linux-base                              3.5

Versions of packages linux-image-4.5.0-trunk-armmp-lpae recommends:
ii  firmware-linux-free  3.3
ii  irqbalance           1.0.6-3

Versions of packages linux-image-4.5.0-trunk-armmp-lpae suggests:
pn  debian-kernel-handbook  <none>
pn  fdutils                 <none>
pn  linux-doc-4.5           <none>

Versions of packages linux-image-4.5.0-trunk-armmp-lpae is related to:
pn  firmware-atheros        <none>
pn  firmware-bnx2           <none>
pn  firmware-bnx2x          <none>
pn  firmware-brcm80211      <none>
pn  firmware-intelwimax     <none>
pn  firmware-ipw2x00        <none>
pn  firmware-ivtv           <none>
pn  firmware-iwlwifi        <none>
pn  firmware-libertas       <none>
pn  firmware-linux          <none>
pn  firmware-linux-nonfree  <none>
pn  firmware-myricom        <none>
pn  firmware-netxen         <none>
pn  firmware-qlogic         <none>
pn  firmware-ralink         <none>
pn  firmware-realtek        <none>
pn  xen-hypervisor          <none>

-- debconf information excluded

[toc] | [next] | [standalone]


#730272

FromBen Hutchings <ben@decadent.org.uk>
Date2016-04-10 21:20 +0200
Message-ID<rmt3R-1mn-33@gated-at.bofh.it>
In reply to#730256

[Multipart message — attachments visible in raw view] — view raw

Control: tag -1 moreinfo

On Sun, 2016-04-10 at 11:15 -0700, Vagrant Cascadian wrote:
> Package: src:linux
> Version: 4.5-1~exp1
> Severity: normal
> 
> Thanks for enabling support for raspberry pi 2!

Thanks for confirming it works, because I was working without any
access to hardware.  I see you've updated flash-kernel to support it as
well.

> It works for the most part, but floods syslog with messages:
> 
> [501966.870273] net_ratelimit: 35702 callbacks suppressed
> [501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
> 
> It seems to function ok, though I'm not sure if there's degraded
> network performance...
[...]

I understand network performance on all RPi models is poor due to lack
of a built-in Ethernet MAC and the poor design of the USB interface.
Also that message is a generic error message from the usbnet core and
is not specific to the smsc95xx driver.

Were you using the network heavily, or do these messages appear
regardless of the level of network traffic?

I checked the latest Raspbian kernel I could find
(,3.16.7-ckt11-1+deb8u4+rpi1) and they don't have any patches to that
driver (other than adding a module parameter for no good reason).

Ben.

-- 
Ben Hutchings
I'm always amazed by the number of people who take up solipsism because
they heard someone else explain it. - E*Borg on alt.fan.pratchett

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


#730283

FromVagrant Cascadian <vagrant@debian.org>
Date2016-04-10 22:30 +0200
Message-ID<rmu9A-2e3-9@gated-at.bofh.it>
In reply to#730272

[Multipart message — attachments visible in raw view] — view raw

On 2016-04-10, Ben Hutchings wrote:
> On Sun, 2016-04-10 at 11:15 -0700, Vagrant Cascadian wrote:
>> Thanks for enabling support for raspberry pi 2!
>
> Thanks for confirming it works, because I was working without any
> access to hardware.

For what it's worth, I've not been able to get the 4.4.x kernels from
Debian to even show console output with an otherwise identical setup. So
there must be something missing from the backported rpi patchset.


> I see you've updated flash-kernel to support it as
> well.

Yeah, I tested it with the u-boot-rpi package.


>> It works for the most part, but floods syslog with messages:
>> 
>> [501966.870273] net_ratelimit: 35702 callbacks suppressed
>> [501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
>> 
>> It seems to function ok, though I'm not sure if there's degraded
>> network performance...
> [...]
>
> I understand network performance on all RPi models is poor due to lack
> of a built-in Ethernet MAC and the poor design of the USB interface.
> Also that message is a generic error message from the usbnet core and
> is not specific to the smsc95xx driver.
>
> Were you using the network heavily, or do these messages appear
> regardless of the level of network traffic?

They have pretty steady network traffic. I haven't monitored network
traffic with enough granularity to really correlate if the messages
occur at the same time as peak network usage, though.

vnstat --hours output:

 eth0                                                                     19:58 
  ^                 r                                                           
  |                 r                                                           
  |                 r                                                           
  |                 r                                                           
  |                 r                                            r        r     
  |  r              r                          r                 r        r     
  |  r  r         t r                          r     r           r  r     r     
  |  r  r         t r                          r     r           r  r  r  r     
  |  r  r  r     rt r                       r  r     r     r     r  r  r  r     
  |  r  r  r     rt r           r  r   t    r  r     r  r  r  rt r  r  r  r     
 -+---------------------------------------------------------------------------> 
  |  20 21 22 23 00 01 02 03 04 05 06 07 08 09 10 11 12 13 14 15 16 17 18 19    
                                                                                
 h  rx (KiB)   tx (KiB)      h  rx (KiB)   tx (KiB)      h  rx (KiB)   tx (KiB) 
20    337,957     35,649    04     53,478     17,628    12    252,402      3,730
21    248,322      4,690    05    107,901      3,202    13     67,155     18,629
22    119,047     32,827    06    105,470      5,669    14    170,309      2,387
23     39,099      4,736    07     50,548     68,110    15     66,700     81,917
00    172,232    258,626    08     50,122      3,188    16    397,451     11,037
01    574,549     10,337    09    166,691      2,460    17    246,196     15,701
02     14,133      1,088    10    337,027      6,798    18    215,436     15,847
03        312      2,167    11      9,293        625    19    366,292      8,472

And syslogs of the messages:

Apr 10 08:33:35 rpi2b kernel: [467762.422149] net_ratelimit: 3837 callbacks suppressed
Apr 10 08:33:35 rpi2b kernel: [467762.427247] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 08:33:42 rpi2b kernel: [467769.491572] net_ratelimit: 5501 callbacks suppressed
Apr 10 08:33:42 rpi2b kernel: [467769.496651] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:01:45 rpi2b kernel: [469453.280337] net_ratelimit: 996 callbacks suppressed
Apr 10 09:01:45 rpi2b kernel: [469453.285330] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:09:53 rpi2b kernel: [469940.843408] net_ratelimit: 11182 callbacks suppressed
Apr 10 09:09:53 rpi2b kernel: [469940.848708] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:11:13 rpi2b kernel: [470020.740828] net_ratelimit: 4669 callbacks suppressed
Apr 10 09:11:13 rpi2b kernel: [470020.745911] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:28:45 rpi2b kernel: [471072.895953] net_ratelimit: 2945 callbacks suppressed
Apr 10 09:28:45 rpi2b kernel: [471072.901033] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:50:03 rpi2b kernel: [472350.602289] net_ratelimit: 157500 callbacks suppressed
Apr 10 09:50:03 rpi2b kernel: [472350.607546] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:50:08 rpi2b kernel: [472356.167786] net_ratelimit: 6353 callbacks suppressed
Apr 10 09:50:08 rpi2b kernel: [472356.172989] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:51:59 rpi2b kernel: [472466.940525] net_ratelimit: 1425 callbacks suppressed
Apr 10 09:51:59 rpi2b kernel: [472466.945601] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 09:53:57 rpi2b kernel: [472584.987546] net_ratelimit: 14139 callbacks suppressed
Apr 10 09:53:57 rpi2b kernel: [472584.992725] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 10:10:13 rpi2b kernel: [473561.119224] net_ratelimit: 3 callbacks suppressed
Apr 10 10:10:13 rpi2b kernel: [473561.124043] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 10:16:17 rpi2b kernel: [473924.699284] net_ratelimit: 5205 callbacks suppressed
Apr 10 10:16:17 rpi2b kernel: [473924.704365] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 10:16:28 rpi2b kernel: [473935.904254] net_ratelimit: 10133 callbacks suppressed
Apr 10 10:16:28 rpi2b kernel: [473935.909421] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 10:35:05 rpi2b kernel: [475053.184807] net_ratelimit: 8062 callbacks suppressed
Apr 10 10:35:05 rpi2b kernel: [475053.189890] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:01:00 rpi2b kernel: [480207.582729] net_ratelimit: 6493 callbacks suppressed
Apr 10 12:01:00 rpi2b kernel: [480207.587811] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:06:04 rpi2b kernel: [480512.144232] net_ratelimit: 115305 callbacks suppressed
Apr 10 12:06:04 rpi2b kernel: [480512.149507] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:29:53 rpi2b kernel: [481940.856838] net_ratelimit: 2819 callbacks suppressed
Apr 10 12:29:53 rpi2b kernel: [481940.861955] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:30:16 rpi2b kernel: [481964.210273] net_ratelimit: 198781 callbacks suppressed
Apr 10 12:30:16 rpi2b kernel: [481964.215547] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:30:51 rpi2b kernel: [481999.038341] net_ratelimit: 10248 callbacks suppressed
Apr 10 12:30:51 rpi2b kernel: [481999.043517] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:40:17 rpi2b kernel: [482564.627428] net_ratelimit: 3383 callbacks suppressed
Apr 10 12:40:17 rpi2b kernel: [482564.632590] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 12:54:53 rpi2b kernel: [483440.657731] net_ratelimit: 1022 callbacks suppressed
Apr 10 12:54:53 rpi2b kernel: [483440.662936] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 13:31:01 rpi2b kernel: [485609.033646] net_ratelimit: 1617 callbacks suppressed
Apr 10 13:31:01 rpi2b kernel: [485609.038731] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 13:31:06 rpi2b kernel: [485614.263687] net_ratelimit: 2290 callbacks suppressed
Apr 10 13:31:06 rpi2b kernel: [485614.269175] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 14:14:05 rpi2b kernel: [488192.976165] net_ratelimit: 3709 callbacks suppressed
Apr 10 14:14:05 rpi2b kernel: [488192.981246] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 14:18:36 rpi2b kernel: [488464.273960] net_ratelimit: 50687 callbacks suppressed
Apr 10 14:18:36 rpi2b kernel: [488464.279127] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 15:35:04 rpi2b kernel: [493051.771115] net_ratelimit: 3821 callbacks suppressed
Apr 10 15:35:04 rpi2b kernel: [493051.776202] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 15:35:48 rpi2b kernel: [493096.127314] net_ratelimit: 1551 callbacks suppressed
Apr 10 15:35:48 rpi2b kernel: [493096.132393] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 15:56:25 rpi2b kernel: [494332.923756] net_ratelimit: 7916 callbacks suppressed
Apr 10 15:56:25 rpi2b kernel: [494332.929017] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:04:38 rpi2b kernel: [494826.252667] net_ratelimit: 5151 callbacks suppressed
Apr 10 16:04:38 rpi2b rsyslogd-2007: action 'action 17' suspended, next retry is Sun Apr 10 16:06:08 2016 [try http://www.rsyslog.com/e/2007 ]
--
Apr 10 16:11:45 rpi2b kernel: [495253.066947] net_ratelimit: 102666 callbacks suppressed
Apr 10 16:11:45 rpi2b kernel: [495253.072197] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:11:51 rpi2b kernel: [495258.597974] net_ratelimit: 3469 callbacks suppressed
Apr 10 16:11:51 rpi2b kernel: [495258.603060] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:13:49 rpi2b kernel: [495377.344988] net_ratelimit: 6730 callbacks suppressed
Apr 10 16:13:49 rpi2b kernel: [495377.350245] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:15:38 rpi2b kernel: [495486.272702] net_ratelimit: 6449 callbacks suppressed
Apr 10 16:15:38 rpi2b kernel: [495486.277819] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:36:58 rpi2b kernel: [496765.597285] net_ratelimit: 1149 callbacks suppressed
Apr 10 16:36:58 rpi2b kernel: [496765.602399] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:39:38 rpi2b kernel: [496926.378173] net_ratelimit: 853 callbacks suppressed
Apr 10 16:39:38 rpi2b kernel: [496926.383178] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:39:43 rpi2b kernel: [496931.412674] net_ratelimit: 6206 callbacks suppressed
Apr 10 16:39:43 rpi2b kernel: [496931.417762] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 16:50:06 rpi2b kernel: [497554.490001] net_ratelimit: 285 callbacks suppressed
Apr 10 16:50:06 rpi2b kernel: [497554.495003] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 17:00:31 rpi2b kernel: [498179.500059] net_ratelimit: 5196 callbacks suppressed
Apr 10 17:00:31 rpi2b kernel: [498179.505139] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 17:08:40 rpi2b kernel: [498667.628700] net_ratelimit: 6384 callbacks suppressed
Apr 10 17:08:40 rpi2b kernel: [498667.633789] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 17:54:06 rpi2b kernel: [501393.624239] net_ratelimit: 2507 callbacks suppressed
Apr 10 17:54:06 rpi2b kernel: [501393.629322] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 17:54:11 rpi2b kernel: [501398.653810] net_ratelimit: 8090 callbacks suppressed
Apr 10 17:54:11 rpi2b kernel: [501398.658895] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:01:02 rpi2b kernel: [501810.019931] net_ratelimit: 53262 callbacks suppressed
Apr 10 18:01:02 rpi2b kernel: [501810.025102] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:03:39 rpi2b kernel: [501966.870273] net_ratelimit: 35702 callbacks suppressed
Apr 10 18:03:39 rpi2b kernel: [501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:11:43 rpi2b kernel: [502451.615588] net_ratelimit: 2384 callbacks suppressed
Apr 10 18:11:43 rpi2b kernel: [502451.620676] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:28:44 rpi2b kernel: [503471.904882] net_ratelimit: 5123 callbacks suppressed
Apr 10 18:28:44 rpi2b kernel: [503471.909978] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:33:49 rpi2b kernel: [503777.331179] net_ratelimit: 3758 callbacks suppressed
Apr 10 18:33:49 rpi2b kernel: [503777.336272] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:40:11 rpi2b kernel: [504159.134987] net_ratelimit: 10597 callbacks suppressed
Apr 10 18:40:11 rpi2b kernel: [504159.140155] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:46:23 rpi2b kernel: [504531.409814] net_ratelimit: 7776 callbacks suppressed
Apr 10 18:46:23 rpi2b kernel: [504531.414892] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:52:52 rpi2b kernel: [504919.698948] net_ratelimit: 3603 callbacks suppressed
Apr 10 18:52:52 rpi2b kernel: [504919.704026] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:58:39 rpi2b kernel: [505267.384080] net_ratelimit: 4970 callbacks suppressed
Apr 10 18:58:39 rpi2b kernel: [505267.389176] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 18:59:49 rpi2b kernel: [505336.769407] net_ratelimit: 18579 callbacks suppressed
Apr 10 18:59:49 rpi2b kernel: [505336.774594] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:01:37 rpi2b kernel: [505445.057601] net_ratelimit: 87221 callbacks suppressed
Apr 10 19:01:37 rpi2b kernel: [505445.062773] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:01:44 rpi2b kernel: [505452.384320] net_ratelimit: 8965 callbacks suppressed
Apr 10 19:01:44 rpi2b kernel: [505452.389442] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:01:55 rpi2b kernel: [505463.478375] net_ratelimit: 111481 callbacks suppressed
Apr 10 19:01:55 rpi2b kernel: [505463.483638] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:08:48 rpi2b kernel: [505875.762474] net_ratelimit: 2558 callbacks suppressed
Apr 10 19:08:48 rpi2b kernel: [505875.767551] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:16:29 rpi2b kernel: [506337.076536] net_ratelimit: 6567 callbacks suppressed
Apr 10 19:16:29 rpi2b kernel: [506337.081621] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:26:13 rpi2b kernel: [506920.946675] net_ratelimit: 6931 callbacks suppressed
Apr 10 19:26:13 rpi2b kernel: [506920.951755] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:35:10 rpi2b kernel: [507457.887241] net_ratelimit: 1640 callbacks suppressed
Apr 10 19:35:10 rpi2b kernel: [507457.892337] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:38:27 rpi2b kernel: [507654.894586] net_ratelimit: 19932 callbacks suppressed
Apr 10 19:38:27 rpi2b kernel: [507654.899764] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:47:53 rpi2b kernel: [508220.993381] net_ratelimit: 70230 callbacks suppressed
Apr 10 19:47:53 rpi2b kernel: [508220.998559] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:51:11 rpi2b kernel: [508419.077738] net_ratelimit: 10991 callbacks suppressed
Apr 10 19:51:11 rpi2b kernel: [508419.082906] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:59:43 rpi2b kernel: [508931.421963] net_ratelimit: 4082 callbacks suppressed
Apr 10 19:59:43 rpi2b kernel: [508931.427121] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 19:59:49 rpi2b kernel: [508936.982523] net_ratelimit: 4054 callbacks suppressed
Apr 10 19:59:49 rpi2b kernel: [508936.987604] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 20:03:12 rpi2b kernel: [509139.802610] net_ratelimit: 3984 callbacks suppressed
Apr 10 20:03:12 rpi2b kernel: [509139.807699] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
--
Apr 10 20:05:07 rpi2b kernel: [509254.841218] net_ratelimit: 120140 callbacks suppressed
Apr 10 20:05:07 rpi2b kernel: [509254.846498] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped



> I checked the latest Raspbian kernel I could find
> (,3.16.7-ckt11-1+deb8u4+rpi1) and they don't have any patches to that
> driver (other than adding a module parameter for no good reason).

Thanks for looking into it!


live well,
  vagrant

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


#730294 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromDiederik de Haas <didi.debian@cknow.org>
Date2016-04-10 23:00 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rmuCC-2to-21@gated-at.bofh.it>
In reply to#730272

[Multipart message — attachments visible in raw view] — view raw

On Sun, 10 Apr 2016 20:14:19 +0100 Ben Hutchings <ben@decadent.org.uk> wrote:
> I checked the latest Raspbian kernel I could find
> (,3.16.7-ckt11-1+deb8u4+rpi1) and they don't have any patches to that
> driver (other than adding a module parameter for no good reason).

Where did you look?
At https://plugwash.raspbian.org/linux_3.18/ you can find the things for the 
latest raspbian.org kernel.

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


#730325 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromBen Hutchings <ben@decadent.org.uk>
Date2016-04-11 02:20 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rmxK9-579-1@gated-at.bofh.it>
In reply to#730294

[Multipart message — attachments visible in raw view] — view raw

On Sun, 2016-04-10 at 22:49 +0200, Diederik de Haas wrote:
> On Sun, 10 Apr 2016 20:14:19 +0100 Ben Hutchings <ben@decadent.org.uk
> > wrote:
> > 
> > I checked the latest Raspbian kernel I could find
> > (,3.16.7-ckt11-1+deb8u4+rpi1) and they don't have any patches to that
> > driver (other than adding a module parameter for no good reason).
> Where did you look?

Under http://archive.raspbian.org/raspbian/pool/main/l/linux/

> At https://plugwash.raspbian.org/linux_3.18/ you can find the things for the 
> latest raspbian.org kernel.

Thanks.  That has a patch to turn off the turbo_mode module parameter
by default.

Vagrant, could you try putting "options smsc95xx turbo_mode=N" in
/etc/modprobe.d/smsc95xx.conf ?

Ben.

-- 
Ben Hutchings
Humans are not rational beings; they are rationalising beings.

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


#730333 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-04-11 03:10 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rmywx-5QK-3@gated-at.bofh.it>
In reply to#730325

[Multipart message — attachments visible in raw view] — view raw

On 2016-04-10, Ben Hutchings wrote:
> On Sun, 2016-04-10 at 22:49 +0200, Diederik de Haas wrote:
>> At https://plugwash.raspbian.org/linux_3.18/ you can find the things for the 
>> latest raspbian.org kernel.
>
> Thanks.  That has a patch to turn off the turbo_mode module parameter
> by default.
>
> Vagrant, could you try putting "options smsc95xx turbo_mode=N" in
> /etc/modprobe.d/smsc95xx.conf ?

Added to one of the two machines, updated the initramfs (just in case
the module gets loaded in initramfs), and rebooted ... will see if that
works.

The other option I was pointed to was to update to the latest boot
firmware, though I haven't tried that yet:

  https://wiki.gentoo.org/wiki/Raspberry_Pi#Troubleshooting

  Troubleshooting

    Problem: dmesg is full of smsc95xx 1-1.1:1.0: eth0: kevent 2 may
    have been dropped and/or page allocation failure messages:
            Solution: Try to update all firmware files in /boot,
    especially fixup.dat.
            Solution: If the former fails, add smsc95xx.turbo_mode=N to
    kernel parameters, or vm.min_free_kbytes=4096 to /etc/sysctl.conf


live well,
  vagrant

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


#730461 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-04-11 17:20 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rmLN8-7Xx-11@gated-at.bofh.it>
In reply to#730333

[Multipart message — attachments visible in raw view] — view raw

On 2016-04-10, Vagrant Cascadian wrote:
> On 2016-04-10, Ben Hutchings wrote:

>> Vagrant, could you try putting "options smsc95xx turbo_mode=N" in
>> /etc/modprobe.d/smsc95xx.conf ?
>
> Added to one of the two machines, updated the initramfs (just in case
> the module gets loaded in initramfs), and rebooted ... will see if that
> works.

Haven't seen any messages since adding those module options, so that's
at least a viable workaround.


live well,
  vagrant

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


#731010 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-04-13 20:50 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rny1s-5Eb-11@gated-at.bofh.it>
In reply to#730333

[Multipart message — attachments visible in raw view] — view raw

On 2016-04-10, Vagrant Cascadian wrote:
> On 2016-04-10, Ben Hutchings wrote:
>> On Sun, 2016-04-10 at 22:49 +0200, Diederik de Haas wrote:
>>> At https://plugwash.raspbian.org/linux_3.18/ you can find the things for the 
>>> latest raspbian.org kernel.
>>
>> Thanks.  That has a patch to turn off the turbo_mode module parameter
>> by default.
>>
>> Vagrant, could you try putting "options smsc95xx turbo_mode=N" in
>> /etc/modprobe.d/smsc95xx.conf ?
>
> Added to one of the two machines, updated the initramfs (just in case
> the module gets loaded in initramfs), and rebooted ... will see if that
> works.
>
> The other option I was pointed to was to update to the latest boot
> firmware, though I haven't tried that yet:

New boot firmware didn't help. Configuring the module to not use
turbo_mode did.

live well,
  vagrant

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


#735100 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromBen Hutchings <ben@decadent.org.uk>
Date2016-04-28 17:20 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rsVTs-5A5-13@gated-at.bofh.it>
In reply to#731010

[Multipart message — attachments visible in raw view] — view raw

Control: tag -1 patch moreinfo

On Wed, 2016-04-13 at 11:43 -0700, Vagrant Cascadian wrote:
> On 2016-04-10, Vagrant Cascadian wrote:
> > 
> > On 2016-04-10, Ben Hutchings wrote:
> > > 
> > > On Sun, 2016-04-10 at 22:49 +0200, Diederik de Haas wrote:
> > > > 
> > > > At https://plugwash.raspbian.org/linux_3.18/ you can find the
> > > > things for the 
> > > > latest raspbian.org kernel.
> > > Thanks.  That has a patch to turn off the turbo_mode module
> > > parameter
> > > by default.
> > > 
> > > Vagrant, could you try putting "options smsc95xx turbo_mode=N" in
> > > /etc/modprobe.d/smsc95xx.conf ?
> > Added to one of the two machines, updated the initramfs (just in
> > case
> > the module gets loaded in initramfs), and rebooted ... will see if
> > that
> > works.
> > 
> > The other option I was pointed to was to update to the latest boot
> > firmware, though I haven't tried that yet:
> New boot firmware didn't help. Configuring the module to not use
> turbo_mode did.

Could you test with turbo_mode re-enabled and with this patch applied?

Also could you test network receive throughput (e.g. with netperf -t
TCP_STREAM, sending *to* the RPi) in these three different
configurations:

1. turbo_mode=0
2. turbo_mode=1, current driver
3. turbo_mode=1, patched driver

(Unfortunately netperf is non-free due to a slightly weird licence.
Also take care to remove it afterwards as the server allows a trivial
network DoS if you leave it running...)

Ben.

-- 
Ben Hutchings
All extremists should be taken out and shot.

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


#735103 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromDiederik de Haas <didi.debian@cknow.org>
Date2016-04-28 17:40 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rsWcO-5NB-15@gated-at.bofh.it>
In reply to#735100

[Multipart message — attachments visible in raw view] — view raw

On Thursday 28 April 2016 17:12:27 Ben Hutchings wrote:
> Could you test with turbo_mode re-enabled and with this patch applied?

Which patch? (or do I need more coffee?)
I did find a commit in git which may be related, but I didn't see a direct 
reference to this issue.
https://anonscm.debian.org/cgit/kernel/linux.git/commit/?h=sid&id=76d0845dce198a77d063aac386886c0bc8c3330b

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


#735112 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromBen Hutchings <ben@decadent.org.uk>
Date2016-04-28 18:20 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rsWPK-6Ft-13@gated-at.bofh.it>
In reply to#735103

[Multipart message — attachments visible in raw view] — view raw

On Thu, 2016-04-28 at 17:30 +0200, Diederik de Haas wrote:
> On Thursday 28 April 2016 17:12:27 Ben Hutchings wrote:
> > 
> > Could you test with turbo_mode re-enabled and with this patch applied?
> Which patch? (or do I need more coffee?)
> I did find a commit in git which may be related, but I didn't see a direct 
> reference to this issue.
> https://anonscm.debian.org/cgit/kernel/linux.git/commit/?h=sid&id=76d0845dce198a77d063aac386886c0bc8c3330b

D'oh.  Here it is.

Ben.

-- 
Ben Hutchings
All extremists should be taken out and shot.

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


#735856 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-05-02 03:30 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<ruaQp-2AB-1@gated-at.bofh.it>
In reply to#735100

[Multipart message — attachments visible in raw view] — view raw

Control: tag 820622 -moreinfo

On 2016-04-28, Ben Hutchings wrote:

> Could you test with turbo_mode re-enabled and with this patch applied?
>
> Also could you test network receive throughput (e.g. with netperf -t
> TCP_STREAM, sending *to* the RPi) in these three different
> configurations:

Ok, if I understood you correctly...

Installed netperf on another machine, and ran:

  netperf -t TCP_STREAM 10.0.0.50

Where 10.0.0.50 is the raspberry pi 2.

Ran netperf twice for each combination, rebooting the raspberry pi 2
between changes in turbo_mode or kernel. Double-checked
/sys/module/smsc95xx/parameters/turbo_mode contained N when booted with
turbo_mode=0, and Y when turbo_mode=1.

To my untrained eye, doesn't look like a significant difference between
any of the modes. None of them triggered the kernel messages that
prompted the bug report.


> 1. turbo_mode=0

  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to localhost () port 0 AF_INET : demo
  Recv   Send    Send
  Socket Socket  Message  Elapsed
  Size   Size    Size     Time     Throughput
  bytes  bytes   bytes    secs.    10^6bits/sec
  
   87380  16384  16384    10.02    1781.22

  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to localhost () port 0 AF_INET : demo
  Recv   Send    Send
  Socket Socket  Message  Elapsed
  Size   Size    Size     Time     Throughput
  bytes  bytes   bytes    secs.    10^6bits/sec
  
   87380  16384  16384    10.02    1847.21


> 2. turbo_mode=1, current driver

  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to localhost () port 0 AF_INET : demo
  Recv   Send    Send                          
  Socket Socket  Message  Elapsed              
  Size   Size    Size     Time     Throughput  
  bytes  bytes   bytes    secs.    10^6bits/sec  
  
   87380  16384  16384    10.02    1812.38   
  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to localhost () port 0 AF_INET : demo
  Recv   Send    Send                          
  Socket Socket  Message  Elapsed              
  Size   Size    Size     Time     Throughput  
  bytes  bytes   bytes    secs.    10^6bits/sec  
  
   87380  16384  16384    10.02    1843.34   


> 3. turbo_mode=1, patched driver

  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to localhost () port 0 AF_INET : demo
  Recv   Send    Send                          
  Socket Socket  Message  Elapsed              
  Size   Size    Size     Time     Throughput  
  bytes  bytes   bytes    secs.    10^6bits/sec  
  
   87380  16384  16384    10.03    1822.99   
  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to localhost () port 0 AF_INET : demo
  Recv   Send    Send                          
  Socket Socket  Message  Elapsed              
  Size   Size    Size     Time     Throughput  
  bytes  bytes   bytes    secs.    10^6bits/sec  
  
   87380  16384  16384    10.03    1824.52   


live well,
  vagrant

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


#736010 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromBen Hutchings <ben@decadent.org.uk>
Date2016-05-02 21:00 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rurey-nY-25@gated-at.bofh.it>
In reply to#735856

[Multipart message — attachments visible in raw view] — view raw

On Sun, 2016-05-01 at 18:20 -0700, Vagrant Cascadian wrote:
> Control: tag 820622 -moreinfo
> 
> On 2016-04-28, Ben Hutchings wrote:
> 
> > 
> > Could you test with turbo_mode re-enabled and with this patch applied?
> > 
> > Also could you test network receive throughput (e.g. with netperf -t
> > TCP_STREAM, sending *to* the RPi) in these three different
> > configurations:
> Ok, if I understood you correctly...
> 
> Installed netperf on another machine, and ran:
> 
>   netperf -t TCP_STREAM 10.0.0.50

That is not correct syntax; you need to put a -H before the IP address.

[...]
> To my untrained eye, doesn't look like a significant difference between
> any of the modes.
[...]

This is not surprising as you did a loopback test on the other machine!

Ben.

-- 
Ben Hutchings
Life is what happens to you while you're busy making other plans.
                                                               - John Lennon

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


#736082 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-05-03 06:10 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<ruzON-PC-3@gated-at.bofh.it>
In reply to#736010

[Multipart message — attachments visible in raw view] — view raw

On 2016-05-02, Ben Hutchings wrote:
> On Sun, 2016-05-01 at 18:20 -0700, Vagrant Cascadian wrote:
>> On 2016-04-28, Ben Hutchings wrote:
>> > Could you test with turbo_mode re-enabled and with this patch applied?
>> > 
>> > Also could you test network receive throughput (e.g. with netperf -t
>> > TCP_STREAM, sending *to* the RPi) in these three different
>> > configurations:
>> Ok, if I understood you correctly...
>> 
>> Installed netperf on another machine, and ran:
>> 
>>   netperf -t TCP_STREAM 10.0.0.50
>
> That is not correct syntax; you need to put a -H before the IP address.

Ok. Never used netperf before... will try again!

For what it's worth, the patched driver did still appear to eventually
generate the error logs reported:

  smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

So at best, it reduces the problem, rather than solving it.


live well,
  vagrant

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


#736196 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromVagrant Cascadian <vagrant@debian.org>
Date2016-05-03 18:20 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<ruLdg-2QH-5@gated-at.bofh.it>
In reply to#736082

[Multipart message — attachments visible in raw view] — view raw

On 2016-05-02, Vagrant Cascadian wrote:
> On 2016-05-02, Ben Hutchings wrote:
>> On Sun, 2016-05-01 at 18:20 -0700, Vagrant Cascadian wrote:
>>> On 2016-04-28, Ben Hutchings wrote:
>>> > Could you test with turbo_mode re-enabled and with this patch applied?
>>> > 
>>> > Also could you test network receive throughput (e.g. with netperf -t
>>> > TCP_STREAM, sending *to* the RPi) in these three different
>>> > configurations:
>>> Ok, if I understood you correctly...
>>> 
>>> Installed netperf on another machine, and ran:
>>> 
>>>   netperf -t TCP_STREAM 10.0.0.50
>>
>> That is not correct syntax; you need to put a -H before the IP address.
>
> Ok. Never used netperf before... will try again!

Ok, this time with:

  netperf -l 60 -t TCP_STREAM -H 10.0.0.50

4.5.2-1, with turbo disabled:
  
  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to 10.0.0.50 ()
  port 0 AF_INET : demo
  Recv   Send    Send
  Socket Socket  Message  Elapsed
  Size   Size    Size     Time     Throughput
  bytes  bytes   bytes    secs.    10^6bits/sec
  
   87380  16384  16384    60.04      93.95
  
4.5.2-1, with turbo enabled:
  
  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to 10.0.0.50 ()
  port 0 AF_INET : demo
  Recv   Send    Send
  Socket Socket  Message  Elapsed
  Size   Size    Size     Time     Throughput
  bytes  bytes   bytes    secs.    10^6bits/sec
  
   87380  16384  16384    60.03      94.15
  
  
4.5.2, patched with turbo enabled:
  
  MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to 10.0.0.50 ()
  port 0 AF_INET : demo
  Recv   Send    Send
  Socket Socket  Message  Elapsed
  Size   Size    Size     Time     Throughput
  bytes  bytes   bytes    secs.    10^6bits/sec
  
   87380  16384  16384    60.04      94.15


live well,
  vagrant

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


#737013 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromBen Hutchings <ben@decadent.org.uk>
Date2016-05-07 13:50 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rw8U9-PG-3@gated-at.bofh.it>
In reply to#736196

[Multipart message — attachments visible in raw view] — view raw

On Tue, 2016-05-03 at 09:13 -0700, Vagrant Cascadian wrote:

> On 2016-05-02, Vagrant Cascadian wrote:
> > 
> > On 2016-05-02, Ben Hutchings wrote:
> > > 
> > > On Sun, 2016-05-01 at 18:20 -0700, Vagrant Cascadian wrote:
> > > > 
> > > > On 2016-04-28, Ben Hutchings wrote:
> > > > > 
> > > > > Could you test with turbo_mode re-enabled and with this patch applied?
> > > > > 
> > > > > Also could you test network receive throughput (e.g. with netperf -t
> > > > > TCP_STREAM, sending *to* the RPi) in these three different
> > > > > configurations:
> > > > Ok, if I understood you correctly...
> > > > 
> > > > Installed netperf on another machine, and ran:
> > > > 
> > > >   netperf -t TCP_STREAM 10.0.0.50
> > > That is not correct syntax; you need to put a -H before the IP address.
> > Ok. Never used netperf before... will try again!
> Ok, this time with:
> 
>   netperf -l 60 -t TCP_STREAM -H 10.0.0.50
> 
> 4.5.2-1, with turbo disabled:
>   
>   MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to 10.0.0.50 ()
>   port 0 AF_INET : demo
>   Recv   Send    Send
>   Socket Socket  Message  Elapsed
>   Size   Size    Size     Time     Throughput
>   bytes  bytes   bytes    secs.    10^6bits/sec
>   
>    87380  16384  16384    60.04      93.95

Interesting - it's very close to saturating the link even without
turbo.  (The maximum possible TCP throughput over and Ethernet with
standard MTU is about 94% of the underling bit rate.)

> 4.5.2-1, with turbo enabled:
>   
>   MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to 10.0.0.50 ()
>   port 0 AF_INET : demo
>   Recv   Send    Send
>   Socket Socket  Message  Elapsed
>   Size   Size    Size     Time     Throughput
>   bytes  bytes   bytes    secs.    10^6bits/sec
>   
>    87380  16384  16384    60.03      94.15
>   
>   
> 4.5.2, patched with turbo enabled:
>   
>   MIGRATED TCP STREAM TEST from 0.0.0.0 () port 0 AF_INET to 10.0.0.50 ()
>   port 0 AF_INET : demo
>   Recv   Send    Send
>   Socket Socket  Message  Elapsed
>   Size   Size    Size     Time     Throughput
>   bytes  bytes   bytes    secs.    10^6bits/sec
>   
>    87380  16384  16384    60.04      94.15

So the patch doesn't seem to hurt performance at all.

From your previous mail:

> For what it's worth, the patched driver did still appear to eventually
> generate the error logs reported:
> 
>   smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
> 
> So at best, it reduces the problem, rather than solving it.

I think the basic problem is you're giving this machine more tasks than
will comfortably fit in its memory, added to which the swap device is
slow (or maybe you disabled swap?).  If this patch reduces the risk of
failed buffer allocations then I think it's still a win.

Ben.

-- 
Ben Hutchings
Editing code like this is akin to sticking plasters on the bleeding stump
of a severed limb. - me, 29 June 1999

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


#737019 — Bug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped

FromDiederik de Haas <didi.debian@cknow.org>
Date2016-05-07 14:10 +0200
SubjectBug#820622: linux-image-4.5.0-trunk-armmp-lpae: raspberry pi 2: smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
Message-ID<rw9dv-1ix-13@gated-at.bofh.it>
In reply to#737013

[Multipart message — attachments visible in raw view] — view raw

On Saturday 07 May 2016 12:44:41 Ben Hutchings wrote:
> If this patch reduces the risk of
> failed buffer allocations then I think it's still a win.

I agree (fwiw).

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


#730380

FromBjørn Mork <bjorn@mork.no>
Date2016-04-11 10:20 +0200
Message-ID<rmFeH-2HC-31@gated-at.bofh.it>
In reply to#730256
Ben Hutchings <ben@decadent.org.uk> writes:
> On Sun, 2016-04-10 at 11:15 -0700, Vagrant Cascadian wrote:
>> It works for the most part, but floods syslog with messages:
>> 
>> [501966.870273] net_ratelimit: 35702 callbacks suppressed
>> [501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
>> 
>> It seems to function ok, though I'm not sure if there's degraded
>> network performance...
> [...]
>
> I understand network performance on all RPi models is poor due to lack
> of a built-in Ethernet MAC and the poor design of the USB interface.
> Also that message is a generic error message from the usbnet core and
> is not specific to the smsc95xx driver.

Yes, kevent 2 is "EVENT_RX_MEMORY", and this error affects any usbnet
based device under memory pressure.  The usbnet framework just doesn't
handle the case where GFP_KERNEL allocations fail. How could it? 

The only viable "fix" I can see is by preallocating and recycling all
buffers instead of the repeated allocations done by usbnet now.  But
that's a major refactoring of usbnet.

The log message spam could of course be fixed, but the rate-limiting is
"good enough".


Bjørn

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


#730407

FromBen Hutchings <ben@decadent.org.uk>
Date2016-04-11 13:30 +0200
Message-ID<rmIcy-51x-5@gated-at.bofh.it>
In reply to#730380

[Multipart message — attachments visible in raw view] — view raw

On Mon, 2016-04-11 at 09:55 +0200, Bjørn Mork wrote:
> Ben Hutchings <ben@decadent.org.uk> writes:
> > 
> > On Sun, 2016-04-10 at 11:15 -0700, Vagrant Cascadian wrote:
> > > 
> > > It works for the most part, but floods syslog with messages:
> > > 
> > > [501966.870273] net_ratelimit: 35702 callbacks suppressed
> > > [501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
> > > 
> > > It seems to function ok, though I'm not sure if there's degraded
> > > network performance...
> > [...]
> > 
> > I understand network performance on all RPi models is poor due to lack
> > of a built-in Ethernet MAC and the poor design of the USB interface.
> > Also that message is a generic error message from the usbnet core and
> > is not specific to the smsc95xx driver.
> Yes, kevent 2 is "EVENT_RX_MEMORY", and this error affects any usbnet
> based device under memory pressure.  The usbnet framework just doesn't
> handle the case where GFP_KERNEL allocations fail. How could it? 

What I don't understand, given this, is why Vagrant didn't report any
OOM warnings.  (I wondered whether the __GFP_NOWARN flag was wrongly
being added somewhere, but I don't see that.)

> The only viable "fix" I can see is by preallocating and recycling all
> buffers instead of the repeated allocations done by usbnet now.  But
> that's a major refactoring of usbnet.
> 
> The log message spam could of course be fixed, but the rate-limiting is
> "good enough".

How is anyone supposed to know what "kevent 2" is though?

The drivers that support batching into large RX buffers should
automatically fall back to smaller buffers if this happens, or whenever
they're running on a small (for some definition of small) machine.  I
understand that the dynamic fallback may be tricky though.

Ben.

-- 
Ben Hutchings
Humans are not rational beings; they are rationalising beings.

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


#730428

FromBjørn Mork <bjorn@mork.no>
Date2016-04-11 15:10 +0200
Message-ID<rmJLj-6qZ-1@gated-at.bofh.it>
In reply to#730407
Ben Hutchings <ben@decadent.org.uk> writes:
> On Mon, 2016-04-11 at 09:55 +0200, Bjørn Mork wrote:
>> Ben Hutchings <ben@decadent.org.uk> writes:
>> > 
>> > On Sun, 2016-04-10 at 11:15 -0700, Vagrant Cascadian wrote:
>> > > 
>> > > It works for the most part, but floods syslog with messages:
>> > > 
>> > > [501966.870273] net_ratelimit: 35702 callbacks suppressed
>> > > [501966.875438] smsc95xx 1-1.1:1.0 eth0: kevent 2 may have been dropped
>> > > 
>> > > It seems to function ok, though I'm not sure if there's degraded
>> > > network performance...
>> > [...]
>> > 
>> > I understand network performance on all RPi models is poor due to lack
>> > of a built-in Ethernet MAC and the poor design of the USB interface.
>> > Also that message is a generic error message from the usbnet core and
>> > is not specific to the smsc95xx driver.
>> Yes, kevent 2 is "EVENT_RX_MEMORY", and this error affects any usbnet
>> based device under memory pressure.  The usbnet framework just doesn't
>> handle the case where GFP_KERNEL allocations fail. How could it? 
>
> What I don't understand, given this, is why Vagrant didn't report any
> OOM warnings.  (I wondered whether the __GFP_NOWARN flag was wrongly
> being added somewhere, but I don't see that.)

Maybe I'm wrong?  Looking at this again, I notice that rx_submit()
always will call usb_submit_urb(urb, GFP_ATOMIC) regardless of the input
mem_flags, because it's holding a spinlock when submitting the urb.  So
it doesn't necessarily help much that the urb and skb are allocated with
GFP_KERNEL.

Exactly what allocations usb_submit_urb() may end up with seems to be
depending on the host controller. So the error spam could very well be
caused by a problematic host controller.  At least partly.

>> The only viable "fix" I can see is by preallocating and recycling all
>> buffers instead of the repeated allocations done by usbnet now.  But
>> that's a major refactoring of usbnet.
>> 
>> The log message spam could of course be fixed, but the rate-limiting is
>> "good enough".
>
> How is anyone supposed to know what "kevent 2" is though?

By looking it up in include/linux/usb/usbnet.h :)

Yes, that could certainly be improved by translating the number back to
a readable description.  

> The drivers that support batching into large RX buffers should
> automatically fall back to smaller buffers if this happens, or whenever
> they're running on a small (for some definition of small) machine.  I
> understand that the dynamic fallback may be tricky though.

I don't think the smsc95xx use any large buffers.  Looks like it's an
ethernet packet + 12 bytes.  And usbnet limits the total rx queue to
60 * 1518 bytes.


Bjørn

[toc] | [prev] | [standalone]


Back to top | Article view | linux.debian.bugs.dist


csiph-web