Kernel Crash when using dwc_otg.speed=1 on an RPI3 with Stretch

[dl1esk]

Hi there,

i use the Repeater Software Svxlink ( https://github.com/sm0svx/svxlink ) in Combination with an Raspberry PI 3 and an USB Soundcard. When i force the USB Port to 1.1 i become an Kernel Oops and the system hangs up with the following Messages:

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.323701] Internal error: Oops: 17 [#1] SMP ARM

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.345574] Process svxlink (pid: 875, stack limit = 0xb66bc210)

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.346891] Stack: (0xb66bde80 to 0xb66be000)

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.348218] de80: b65b3f00 00000006 b66bdef4 b66bde98 8017f230 802725 70 60000113 80b7ad40

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.350892] dea0: 80c79814 80c0f5c0 b65b36c0 ba360f80 b920e070 80c723 47 80b7f080 80c0312c

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.353601] dec0: 80c031d0 80c0fb40 b66bdef4 80c020a4 00000009 b66bc0 38 00000100 b9c05180

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.356309] dee0: 00000024 00000200 b66bdf5c b66bdef8 8010169c 8017ec d8 801011e8 b9c88100

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.359048] df00: 00000001 00400040 80c02d00 0003043f 00000008 80c7b9 80 80c726d8 80c0312c

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.361927] df20: 80b793b8 80c02080 b66bdef8 0000000a 80178484 80b7ce c0 00000000 00000000

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.364944] df40: 00000001 b9c05180 00000000 ffffffff b66bdf6c b66bdf 60 80122cf8 8010151c

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.368087] df60: b66bdf94 b66bdf70 8017371c 80122bf8 b66bdfb0 80c046 70 40000010 ffffffff

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.371383] df80: 10c5383d 10c5387d b66bdfac b66bdf98 8010150c 801736 b8 80c040a4 767cdba4

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.374752] dfa0: 00000000 b66bdfb0 8071aa0c 80101470 015b6c48 7ef8fd 18 00000000 7ef8fe04

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.378202] dfc0: 00000007 015b6c48 00000003 00000008 00000065 000000 00 ffffffff 00000004

Message from syslogd@DB0CA at Nov 7 22:58:00 ... kernel:[ 2277.381699] dfe0: 00000008 7ef8fc44 00000009 767cdba4 40000010 ffffff ff e1a00007 0a00008c

---

The same happens on an Raspberry Pi Zero, with the Raspberry Pi 2 it doesnt happen. How can i narrow down the Problem ?!

73 Sebastian

[P33M]

Can you provide more of the log output? That's half of the OOPS. Start from where "cut here" appears in the log through to "end trace"

[dl1esk]

i got that Message on my Console, so thats all what i have, because the Raspi doesnt respond anymore when this happens... The Logfiles are written into an Ramdisk to save my SD-Card... Maybe i can switch back that Logfiles will be written on Disk that i can provide an complete Oops Log. Or do u have another solution to narrow down the problem?!

[P33M]

A serial console attached to the GPIO UART is the preferred method of getting information out when the Pi crashes. Do you have a USB-serial adapter that you can use?

Note that you will need to put enable_uart=1 in /boot/config.txt.

[dl1esk]

i got a Log now, something with out of memory...

Nov  9 15:29:38 DB0CA kernel: [ 2054.335622] Unable to handle kernel NULL pointer dereference at virtual address 00000023
Nov  9 15:29:38 DB0CA kernel: [ 2054.339545] pgd = b73b4000
Nov  9 15:29:38 DB0CA kernel: [ 2054.341491] [00000023] *pgd=393a9835, *pte=00000000, *ppte=00000000
Nov  9 15:29:38 DB0CA kernel: [ 2054.343601] Internal error: Oops: 17 [#1] SMP ARM
Nov  9 15:29:38 DB0CA kernel: [ 2054.345660] Modules linked in: cmac bnep hci_uart btbcm bluetooth evdev snd_usb_audio snd_hwdep snd_usbmidi_lib snd_rawmidi snd_seq_device brcmfmac brcmutil cfg80211 rfkill snd_bcm2835 snd_pcm snd_timer snd bcm2835_gpiomem uio_pdrv_genirq uio fixed ip_tables x_tables ipv6
Nov  9 15:29:38 DB0CA kernel: [ 2054.355191] CPU: 0 PID: 339 Comm: python Not tainted 4.9.59-v7+ #1047
Nov  9 15:29:38 DB0CA kernel: [ 2054.357715] Hardware name: BCM2835
Nov  9 15:29:38 DB0CA kernel: [ 2054.360166] task: b9160ec0 task.stack: b92d8000
Nov  9 15:29:38 DB0CA kernel: [ 2054.362739] PC is at eventpoll_release_file+0x2c/0x84
Nov  9 15:29:38 DB0CA kernel: [ 2054.365323] LR is at mutex_lock+0x1c/0x64
Nov  9 15:29:38 DB0CA kernel: [ 2054.367871] pc : [<802bcffc>]    lr : [<80717760>]    psr: a0000013
Nov  9 15:29:38 DB0CA kernel: [ 2054.367871] sp : b92d9ef8  ip : b92d9ee0  fp : b92d9f1c
Nov  9 15:29:38 DB0CA kernel: [ 2054.373117] r10: 00000008  r9 : b6fca9f0  r8 : b9453f94
Nov  9 15:29:38 DB0CA kernel: [ 2054.375720] r7 : b6f913b8  r6 : b9598110  r5 : fffffff3  r4 : b9453f00
Nov  9 15:29:38 DB0CA kernel: [ 2054.378371] r3 : 00000023  r2 : 00000000  r1 : 00000008  r0 : 00000000
Nov  9 15:29:38 DB0CA kernel: [ 2054.381018] Flags: NzCv  IRQs on  FIQs on  Mode SVC_32  ISA ARM  Segment user
Nov  9 15:29:38 DB0CA kernel: [ 2054.383761] Control: 10c5383d  Table: 373b406a  DAC: 00000055
Nov  9 15:29:38 DB0CA kernel: [ 2054.386442] Process python (pid: 339, stack limit = 0xb92d8210)
Nov  9 15:29:38 DB0CA kernel: [ 2054.389082] Stack: (0xb92d9ef8 to 0xb92da000)
Nov  9 15:29:38 DB0CA kernel: [ 2054.391738] 9ee0:                                                       b9453f94 b9453f00
Nov  9 15:29:38 DB0CA kernel: [ 2054.396906] 9f00: b6fca9f0 b9598110 b6f913b8 00000000 b92d9f5c b92d9f20 80272764 802bcfdc
Nov  9 15:29:38 DB0CA kernel: [ 2054.402040] 9f20: 00000000 00000000 b9453f00 b9453f08 b92d9f54 b91613a8 80c7bee0 00000000
Nov  9 15:29:38 DB0CA kernel: [ 2054.407153] 9f40: b9160ec0 80108244 b92d8000 00000000 b92d9f6c b92d9f60 8027281c 802725d0
Nov  9 15:29:38 DB0CA kernel: [ 2054.412333] 9f60: b92d9f8c b92d9f70 8013ac34 80272810 b92d8000 b92d8010 80108244 b92d9fb0
Nov  9 15:29:38 DB0CA kernel: [ 2054.417619] 9f80: b92d9fac b92d9f90 8010b838 8013ab74 0098c748 76e38bec 00000000 00000006
Nov  9 15:29:38 DB0CA kernel: [ 2054.420507] 9fa0: 00000000 b92d9fb0 801080e8 8010b778 00000000 00000444 76e387a8 76d65fc4
Nov  9 15:29:38 DB0CA kernel: [ 2054.423500] 9fc0: 0098c748 76e38bec 00000000 00000006 00971050 002ca000 0098c748 76c94330
Nov  9 15:29:38 DB0CA kernel: [ 2054.426642] 9fe0: 00000000 7eae0580 76d67928 76d65fd4 20000010 00000006 00000000 00000000
Nov  9 15:29:38 DB0CA kernel: [ 2054.429863] [<802bcffc>] (eventpoll_release_file) from [<80272764>] (__fput+0x1a0/0x1e8)
Nov  9 15:29:38 DB0CA kernel: [ 2054.433164] [<80272764>] (__fput) from [<8027281c>] (____fput+0x18/0x1c)
Nov  9 15:29:38 DB0CA kernel: [ 2054.434895] [<8027281c>] (____fput) from [<8013ac34>] (task_work_run+0xcc/0xfc)
Nov  9 15:29:38 DB0CA kernel: [ 2054.436669] [<8013ac34>] (task_work_run) from [<8010b838>] (do_work_pending+0xcc/0xd0)
Nov  9 15:29:38 DB0CA kernel: [ 2054.440089] [<8010b838>] (do_work_pending) from [<801080e8>] (slow_work_pending+0xc/0x20)
Nov  9 15:29:38 DB0CA kernel: [ 2054.443519] Code: eb1169d4 e5b83094 e1580003 e2435030 (e5933000) 
Nov  9 15:29:38 DB0CA kernel: [ 2054.447930] ---[ end trace 701f16df15c4ce47 ]---
Nov  9 15:30:15 DB0CA kernel: [ 2091.254505] kthreadd invoked oom-killer: gfp_mask=0x27000c0(GFP_KERNEL_ACCOUNT|__GFP_NOTRACK), nodemask=0, order=1, oom_score_adj=0
Nov  9 15:30:15 DB0CA kernel: [ 2091.262476] kthreadd cpuset=/ mems_allowed=0
Nov  9 15:30:15 DB0CA kernel: [ 2091.266612] CPU: 1 PID: 2 Comm: kthreadd Tainted: G      D         4.9.59-v7+ #1047
Nov  9 15:30:15 DB0CA kernel: [ 2091.275073] Hardware name: BCM2835
Nov  9 15:30:15 DB0CA kernel: [ 2091.279166] [<8010fb3c>] (unwind_backtrace) from [<8010c058>] (show_stack+0x20/0x24)
Nov  9 15:30:15 DB0CA kernel: [ 2091.287194] [<8010c058>] (show_stack) from [<80456764>] (dump_stack+0xd4/0x118)
Nov  9 15:30:15 DB0CA kernel: [ 2091.291151] [<80456764>] (dump_stack) from [<8026d2ac>] (dump_header+0x9c/0x1f4)
Nov  9 15:30:15 DB0CA kernel: [ 2091.298550] [<8026d2ac>] (dump_header) from [<80210b14>] (oom_kill_process+0x3e0/0x4e4)
Nov  9 15:30:15 DB0CA kernel: [ 2091.305772] [<80210b14>] (oom_kill_process) from [<80210f7c>] (out_of_memory+0x124/0x334)
Nov  9 15:30:15 DB0CA kernel: [ 2091.312610] [<80210f7c>] (out_of_memory) from [<80216120>] (__alloc_pages_nodemask+0xd7c/0xe58)
Nov  9 15:30:15 DB0CA kernel: [ 2091.319467] [<80216120>] (__alloc_pages_nodemask) from [<8011ab38>] (copy_process.part.5+0xec/0x17b0)
Nov  9 15:30:15 DB0CA kernel: [ 2091.326260] [<8011ab38>] (copy_process.part.5) from [<8011c38c>] (_do_fork+0xc8/0x408)
Nov  9 15:30:15 DB0CA kernel: [ 2091.332992] [<8011c38c>] (_do_fork) from [<8011c73c>] (kernel_thread+0x40/0x48)
Nov  9 15:30:15 DB0CA kernel: [ 2091.336447] [<8011c73c>] (kernel_thread) from [<8013d9a8>] (kthreadd+0x1e0/0x268)
Nov  9 15:30:15 DB0CA kernel: [ 2091.343144] [<8013d9a8>] (kthreadd) from [<80108148>] (ret_from_fork+0x14/0x2c)
Nov  9 15:30:15 DB0CA kernel: [ 2091.346532] Mem-Info:
Nov  9 15:30:15 DB0CA kernel: [ 2091.349977] active_anon:222057 inactive_anon:3011 isolated_anon:0
Nov  9 15:30:15 DB0CA kernel: [ 2091.349977]  active_file:76 inactive_file:147 isolated_file:0
Nov  9 15:30:15 DB0CA kernel: [ 2091.349977]  unevictable:0 dirty:0 writeback:0 unstable:0
Nov  9 15:30:15 DB0CA kernel: [ 2091.349977]  slab_reclaimable:1367 slab_unreclaimable:2235
Nov  9 15:30:15 DB0CA kernel: [ 2091.349977]  mapped:285 shmem:3075 pagetables:691 bounce:0
Nov  9 15:30:15 DB0CA kernel: [ 2091.349977]  free:5442 free_pcp:247 free_cma:1694
Nov  9 15:30:15 DB0CA kernel: [ 2091.370579] Node 0 active_anon:888228kB inactive_anon:12044kB active_file:272kB inactive_file:244kB unevictable:0kB isolated(anon):0kB isolated(file):128kB mapped:1044kB dirty:0kB writeback:0kB shmem:12300kB writeback_tmp:0kB unstable:0kB pages_scanned:4282 all_unreclaimable? yes
Nov  9 15:30:15 DB0CA kernel: [ 2091.383543] Normal free:21848kB min:16384kB low:20480kB high:24576kB active_anon:888228kB inactive_anon:12044kB active_file:372kB inactive_file:412kB unevictable:0kB writepending:0kB present:970752kB managed:949580kB mlocked:0kB slab_reclaimable:5468kB slab_unreclaimable:8940kB kernel_stack:1104kB pagetables:2764kB bounce:0kB free_pcp:892kB local_pcp:4kB free_cma:6776kB
Nov  9 15:30:15 DB0CA kernel: lowmem_reserve[]: 0 0
Nov  9 15:30:15 DB0CA kernel: [ 2091.401732] Normal: 83*4kB (UMEHC) 102*8kB (UEH) 64*16kB (UEHC) 39*32kB (UMEHC) 14*64kB (UMEHC) 8*128kB (UMHC) 4*256kB (UMHC) 2*512kB (UM) 2*1024kB (UM) 2*2048kB (UC) 2*4096kB (EC) = 21724kB
Nov  9 15:30:15 DB0CA kernel: 3332 total pagecache pages
Nov  9 15:30:15 DB0CA kernel: [ 2091.413448] 0 pages in swap cache
Nov  9 15:30:15 DB0CA kernel: [ 2091.416179] Swap cache stats: add 0, delete 0, find 0/0
Nov  9 15:30:15 DB0CA kernel: [ 2091.418953] Free swap  = 0kB
Nov  9 15:30:15 DB0CA kernel: [ 2091.421669] Total swap = 0kB
Nov  9 15:30:15 DB0CA kernel: [ 2091.424275] 242688 pages RAM
Nov  9 15:30:15 DB0CA kernel: [ 2091.426799] 0 pages HighMem/MovableOnly
Nov  9 15:30:15 DB0CA kernel: [ 2091.429245] 5293 pages reserved
Nov  9 15:30:15 DB0CA kernel: [ 2091.431711] 2048 pages cma reserved
Nov  9 15:30:15 DB0CA kernel: [ 2091.434201] [ pid ]   uid  tgid total_vm      rss nr_ptes nr_pmds swapents oom_score_adj name
Nov  9 15:30:15 DB0CA kernel: [ 2091.439512] [  110]     0   110     6730      329      10       0        0             0 systemd-journal
Nov  9 15:30:15 DB0CA kernel: [ 2091.444828] [  153]     0   153     3564      168       7       0        0         -1000 systemd-udevd
Nov  9 15:30:15 DB0CA kernel: [ 2091.450141] [  287]   100   287     4320      108      10       0        0             0 systemd-timesyn
Nov  9 15:30:15 DB0CA kernel: [ 2091.455379] [  332] 65534   332     1323       61       7       0        0             0 thd
Nov  9 15:30:15 DB0CA kernel: [ 2091.460513] [  335]   105   335     1626      105       7       0        0          -900 dbus-daemon
Nov  9 15:30:15 DB0CA kernel: [ 2091.465585] [  338]     0   338     1448       63       6       0        0             0 screen
Nov  9 15:30:15 DB0CA kernel: [ 2091.470641] [  341]     0   341     5937       77      10       0        0             0 rsyslogd
Nov  9 15:30:15 DB0CA kernel: [ 2091.475520] [  344]     0   344     1424       55       6       0        0             0 cron
Nov  9 15:30:15 DB0CA kernel: [ 2091.480317] [  351]   108   351     1600       78       7       0        0             0 avahi-daemon
Nov  9 15:30:15 DB0CA kernel: [ 2091.485194] [  353]     0   353     1844      103       7       0        0             0 systemd-logind
Nov  9 15:30:15 DB0CA kernel: [ 2091.490116] [  383]   108   383     1600       78       7       0        0             0 avahi-daemon
Nov  9 15:30:15 DB0CA kernel: [ 2091.495171] [  412]     0   412      458       26       5       0        0             0 autossh
Nov  9 15:30:15 DB0CA kernel: [ 2091.500221] [  434]     0   434     2534      131       8       0        0             0 wpa_supplicant
Nov  9 15:30:15 DB0CA kernel: [ 2091.505111] [  460]     0   460      524       30       3       0        0             0 hciattach
Nov  9 15:30:15 DB0CA kernel: [ 2091.510026] [  464]     0   464     1768       65       8       0        0             0 bluetoothd
Nov  9 15:30:15 DB0CA kernel: [ 2091.514858] [  519]     0   519      737      104       6       0        0             0 dhcpcd
Nov  9 15:30:15 DB0CA kernel: [ 2091.519679] [  521]     0   521     2550      132       8       0        0         -1000 sshd
Nov  9 15:30:15 DB0CA kernel: [ 2091.524467] [  544]     0   544     1150       31       7       0        0             0 agetty
Nov  9 15:30:15 DB0CA kernel: [ 2091.529226] [  545]     0   545   226118   218128     441       0        0             0 svxlink
Nov  9 15:30:15 DB0CA kernel: [ 2091.534126] [  571]     0   571     2486      251       8       0        0             0 ssh
Nov  9 15:30:15 DB0CA kernel: [ 2091.539098] [  572]     0   572     2880      185       9       0        0             0 sshd
Nov  9 15:30:15 DB0CA kernel: [ 2091.544070] [  577]  1000   577     2415      167       9       0        0             0 systemd
Nov  9 15:30:15 DB0CA kernel: [ 2091.549098] [  580]  1000   580     7166      309      12       0        0             0 (sd-pam)
Nov  9 15:30:15 DB0CA kernel: [ 2091.554226] [  587]  1000   587     2880      182       9       0        0             0 sshd
Nov  9 15:30:15 DB0CA kernel: [ 2091.559392] [  590]  1000   590     1643      317       8       0        0             0 bash
Nov  9 15:30:15 DB0CA kernel: [ 2091.564561] [  602]     0   602     1926       95       8       0        0             0 sudo
Nov  9 15:30:15 DB0CA kernel: [ 2091.569782] [  606]     0   606     1818       96       8       0        0             0 su
Nov  9 15:30:15 DB0CA kernel: [ 2091.575033] [  611]     0   611     1415      109       6       0        0             0 bash
Nov  9 15:30:15 DB0CA kernel: [ 2091.580256] [  716]     0   716     2916      182       9       0        0             0 sshd
Nov  9 15:30:15 DB0CA kernel: [ 2091.585647] [  722]     0   722     2298      123       7       0        0             0 systemd
Nov  9 15:30:15 DB0CA kernel: [ 2091.590996] [  725]     0   725     7166      309      12       0        0             0 (sd-pam)
Nov  9 15:30:15 DB0CA kernel: [ 2091.596272] [  732]     0   732      587       43       5       0        0             0 sftp-server
Nov  9 15:30:15 DB0CA kernel: [ 2091.601474] Out of memory: Kill process 545 (svxlink) score 893 or sacrifice child
Nov  9 15:30:15 DB0CA kernel: [ 2091.606963] Killed process 545 (svxlink) total-vm:904472kB, anon-rss:872512kB, file-rss:0kB, shmem-rss:0kB
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Booting Linux on physical CPU 0x0
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Linux version 4.9.59-v7+ (dc4@dc4-XPS13-9333) (gcc version 4.9.3 (crosstool-NG crosstool-ng-1.22.0-88-g8460611) ) #1047 SMP Sun Oct 29 12:19:23 GMT 2017
Nov  9 15:32:59 DB0CA kernel: [    0.000000] CPU: ARMv7 Processor [410fd034] revision 4 (ARMv7), cr=10c5383d
Nov  9 15:32:59 DB0CA kernel: [    0.000000] CPU: div instructions available: patching division code
Nov  9 15:32:59 DB0CA kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT aliasing instruction cache
Nov  9 15:32:59 DB0CA kernel: [    0.000000] OF: fdt:Machine model: Raspberry Pi 3 Model B Rev 1.2
Nov  9 15:32:59 DB0CA kernel: [    0.000000] cma: Reserved 8 MiB at 0x3ac00000
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Memory policy: Data cache writealloc
Nov  9 15:32:59 DB0CA kernel: [    0.000000] On node 0 totalpages: 242688
Nov  9 15:32:59 DB0CA kernel: [    0.000000] free_area_init_node: node 0, pgdat 80c6f380, node_mem_map ba3a1000
Nov  9 15:32:59 DB0CA kernel: [    0.000000]   Normal zone: 2133 pages used for memmap
Nov  9 15:32:59 DB0CA kernel: [    0.000000]   Normal zone: 0 pages reserved
Nov  9 15:32:59 DB0CA kernel: [    0.000000]   Normal zone: 242688 pages, LIFO batch:31
Nov  9 15:32:59 DB0CA kernel: [    0.000000] percpu: Embedded 14 pages/cpu @ba35b000 s25600 r8192 d23552 u57344
Nov  9 15:32:59 DB0CA kernel: [    0.000000] pcpu-alloc: s25600 r8192 d23552 u57344 alloc=14*4096
Nov  9 15:32:59 DB0CA kernel: [    0.000000] pcpu-alloc: [0] 0 [0] 1 [0] 2 [0] 3 
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 240555
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Kernel command line: 8250.nr_uarts=0 bcm2708_fb.fbwidth=656 bcm2708_fb.fbheight=416 bcm2708_fb.fbswap=1 vc_mem.mem_base=0x3ec00000 vc_mem.mem_size=0x40000000  dwc_otg.lpm_enable=0 dwc_otg.speed=1 console=ttyS0,115200 console=tty1 root=PARTUUID=2d256df5-02 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Nov  9 15:32:59 DB0CA kernel: [    0.000000] PID hash table entries: 4096 (order: 2, 16384 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Dentry cache hash table entries: 131072 (order: 7, 524288 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Inode-cache hash table entries: 65536 (order: 6, 262144 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Memory: 940364K/970752K available (7168K kernel code, 486K rwdata, 2012K rodata, 1024K init, 770K bss, 22196K reserved, 8192K cma-reserved)
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Virtual kernel memory layout:
Nov  9 15:32:59 DB0CA kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]     vmalloc : 0xbb800000 - 0xff800000   (1088 MB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]     lowmem  : 0x80000000 - 0xbb400000   ( 948 MB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]     modules : 0x7f000000 - 0x80000000   (  16 MB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]       .text : 0x80008000 - 0x80800000   (8160 kB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]       .init : 0x80b00000 - 0x80c00000   (1024 kB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]       .data : 0x80c00000 - 0x80c79834   ( 487 kB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000]        .bss : 0x80c7b000 - 0x80d3b964   ( 771 kB)
Nov  9 15:32:59 DB0CA kernel: [    0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
Nov  9 15:32:59 DB0CA kernel: [    0.000000] Hierarchical RCU implementation.
Nov  9 15:32:59 DB0CA kernel: [    0.000000]    Build-time adjustment of leaf fanout to 32.
Nov  9 15:32:59 DB0CA kernel: [    0.000000] NR_IRQS:16 nr_irqs:16 16
Nov  9 15:32:59 DB0CA kernel: [    0.000000] arm_arch_timer: Architected cp15 timer(s) running at 19.20MHz (phys).
Nov  9 15:32:59 DB0CA kernel: [    0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x46d987e47, max_idle_ns: 440795202767 ns
Nov  9 15:32:59 DB0CA kernel: [    0.000006] sched_clock: 56 bits at 19MHz, resolution 52ns, wraps every 4398046511078ns
Nov  9 15:32:59 DB0CA kernel: [    0.000022] Switching to timer-based delay loop, resolution 52ns
Nov  9 15:32:59 DB0CA kernel: [    0.000303] Console: colour dummy device 80x30
Nov  9 15:32:59 DB0CA kernel: [    0.001209] console [tty1] enabled
Nov  9 15:32:59 DB0CA kernel: [    0.001252] Calibrating delay loop (skipped), value calculated using timer frequency.. 38.40 BogoMIPS (lpj=192000)
Nov  9 15:32:59 DB0CA kernel: [    0.001321] pid_max: default: 32768 minimum: 301
Nov  9 15:32:59 DB0CA kernel: [    0.001653] Mount-cache hash table entries: 2048 (order: 1, 8192 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.001695] Mountpoint-cache hash table entries: 2048 (order: 1, 8192 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.002727] Disabling memory control group subsystem
Nov  9 15:32:59 DB0CA kernel: [    0.002831] CPU: Testing write buffer coherency: ok
Nov  9 15:32:59 DB0CA kernel: [    0.002895] ftrace: allocating 22392 entries in 66 pages
Nov  9 15:32:59 DB0CA kernel: [    0.049987] CPU0: update cpu_capacity 1024
Nov  9 15:32:59 DB0CA kernel: [    0.050039] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
Nov  9 15:32:59 DB0CA kernel: [    0.050099] Setting up static identity map for 0x100000 - 0x100034
Nov  9 15:32:59 DB0CA kernel: [    0.051986] CPU1: update cpu_capacity 1024
Nov  9 15:32:59 DB0CA kernel: [    0.051994] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
Nov  9 15:32:59 DB0CA kernel: [    0.052676] CPU2: update cpu_capacity 1024
Nov  9 15:32:59 DB0CA kernel: [    0.052683] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
Nov  9 15:32:59 DB0CA kernel: [    0.053353] CPU3: update cpu_capacity 1024
Nov  9 15:32:59 DB0CA kernel: [    0.053360] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
Nov  9 15:32:59 DB0CA kernel: [    0.053447] Brought up 4 CPUs
Nov  9 15:32:59 DB0CA kernel: [    0.053620] SMP: Total of 4 processors activated (153.60 BogoMIPS).
Nov  9 15:32:59 DB0CA kernel: [    0.053649] CPU: All CPU(s) started in HYP mode.
Nov  9 15:32:59 DB0CA kernel: [    0.053676] CPU: Virtualization extensions available.
Nov  9 15:32:59 DB0CA kernel: [    0.054495] devtmpfs: initialized
Nov  9 15:32:59 DB0CA kernel: [    0.065801] VFP support v0.3: implementor 41 architecture 3 part 40 variant 3 rev 4
Nov  9 15:32:59 DB0CA kernel: [    0.066116] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Nov  9 15:32:59 DB0CA kernel: [    0.066177] futex hash table entries: 1024 (order: 4, 65536 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.066735] pinctrl core: initialized pinctrl subsystem
Nov  9 15:32:59 DB0CA kernel: [    0.067667] NET: Registered protocol family 16
Nov  9 15:32:59 DB0CA kernel: [    0.069963] DMA: preallocated 1024 KiB pool for atomic coherent allocations
Nov  9 15:32:59 DB0CA kernel: [    0.078884] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
Nov  9 15:32:59 DB0CA kernel: [    0.078933] hw-breakpoint: maximum watchpoint size is 8 bytes.
Nov  9 15:32:59 DB0CA kernel: [    0.079098] Serial: AMBA PL011 UART driver
Nov  9 15:32:59 DB0CA kernel: [    0.081027] bcm2835-mbox 3f00b880.mailbox: mailbox enabled
Nov  9 15:32:59 DB0CA kernel: [    0.081580] uart-pl011 3f201000.serial: could not find pctldev for node /soc/gpio@7e200000/uart0_pins, deferring probe
Nov  9 15:32:59 DB0CA kernel: [    0.150841] bcm2835-dma 3f007000.dma: DMA legacy API manager at bb80f000, dmachans=0x1
Nov  9 15:32:59 DB0CA kernel: [    0.152707] SCSI subsystem initialized
Nov  9 15:32:59 DB0CA kernel: [    0.152884] usbcore: registered new interface driver usbfs
Nov  9 15:32:59 DB0CA kernel: [    0.152986] usbcore: registered new interface driver hub
Nov  9 15:32:59 DB0CA kernel: [    0.153100] usbcore: registered new device driver usb
Nov  9 15:32:59 DB0CA kernel: [    0.159794] raspberrypi-firmware soc:firmware: Attached to firmware from 2017-10-24 17:09
Nov  9 15:32:59 DB0CA kernel: [    0.161239] clocksource: Switched to clocksource arch_sys_counter
Nov  9 15:32:59 DB0CA kernel: [    0.208316] VFS: Disk quotas dquot_6.6.0
Nov  9 15:32:59 DB0CA kernel: [    0.208426] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.208657] FS-Cache: Loaded
Nov  9 15:32:59 DB0CA kernel: [    0.208929] CacheFiles: Loaded
Nov  9 15:32:59 DB0CA kernel: [    0.221101] NET: Registered protocol family 2
Nov  9 15:32:59 DB0CA kernel: [    0.222023] TCP established hash table entries: 8192 (order: 3, 32768 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.222161] TCP bind hash table entries: 8192 (order: 4, 65536 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.222371] TCP: Hash tables configured (established 8192 bind 8192)
Nov  9 15:32:59 DB0CA kernel: [    0.222484] UDP hash table entries: 512 (order: 2, 16384 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.222551] UDP-Lite hash table entries: 512 (order: 2, 16384 bytes)
Nov  9 15:32:59 DB0CA kernel: [    0.222783] NET: Registered protocol family 1
Nov  9 15:32:59 DB0CA kernel: [    0.223219] RPC: Registered named UNIX socket transport module.
Nov  9 15:32:59 DB0CA kernel: [    0.223251] RPC: Registered udp transport module.
Nov  9 15:32:59 DB0CA kernel: [    0.223279] RPC: Registered tcp transport module.
Nov  9 15:32:59 DB0CA kernel: [    0.223306] RPC: Registered tcp NFSv4.1 backchannel transport module.
Nov  9 15:32:59 DB0CA kernel: [    0.224306] hw perfevents: enabled with armv7_cortex_a7 PMU driver, 7 counters available
Nov  9 15:32:59 DB0CA kernel: [    0.226640] workingset: timestamp_bits=14 max_order=18 bucket_order=4
Nov  9 15:32:59 DB0CA kernel: [    0.242699] FS-Cache: Netfs 'nfs' registered for caching
Nov  9 15:32:59 DB0CA kernel: [    0.243705] NFS: Registering the id_resolver key type
Nov  9 15:32:59 DB0CA kernel: [    0.243754] Key type id_resolver registered
Nov  9 15:32:59 DB0CA kernel: [    0.243782] Key type id_legacy registered
Nov  9 15:32:59 DB0CA kernel: [    0.246225] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
Nov  9 15:32:59 DB0CA kernel: [    0.246371] io scheduler noop registered
Nov  9 15:32:59 DB0CA kernel: [    0.246401] io scheduler deadline registered (default)
Nov  9 15:32:59 DB0CA kernel: [    0.246696] io scheduler cfq registered
Nov  9 15:32:59 DB0CA kernel: [    0.252364] BCM2708FB: allocated DMA memory fad10000
Nov  9 15:32:59 DB0CA kernel: [    0.252418] BCM2708FB: allocated DMA channel 0 @ bb80f000
Nov  9 15:32:59 DB0CA kernel: [    0.261120] Console: switching to colour frame buffer device 82x26
Nov  9 15:32:59 DB0CA kernel: [    0.269562] bcm2835-rng 3f104000.rng: hwrng registered
Nov  9 15:32:59 DB0CA kernel: [    0.271977] vc-mem: phys_addr:0x00000000 mem_base=0x3ec00000 mem_size:0x40000000(1024 MiB)
Nov  9 15:32:59 DB0CA kernel: [    0.277116] vc-sm: Videocore shared memory driver
Nov  9 15:32:59 DB0CA kernel: [    0.294487] brd: module loaded
Nov  9 15:32:59 DB0CA kernel: [    0.305715] loop: module loaded
Nov  9 15:32:59 DB0CA kernel: [    0.308098] Loading iSCSI transport class v2.0-870.
Nov  9 15:32:59 DB0CA kernel: [    0.310938] usbcore: registered new interface driver smsc95xx
Nov  9 15:32:59 DB0CA kernel: [    0.313289] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Nov  9 15:32:59 DB0CA kernel: [    0.543628] Core Release: 2.80a
Nov  9 15:32:59 DB0CA kernel: [    0.545875] Setting default values for core params
Nov  9 15:32:59 DB0CA kernel: [    0.548171] Finished setting default values for core params
Nov  9 15:32:59 DB0CA kernel: [    0.750902] Using Buffer DMA mode
Nov  9 15:32:59 DB0CA kernel: [    0.753191] Periodic Transfer Interrupt Enhancement - disabled
Nov  9 15:32:59 DB0CA kernel: [    0.755475] Multiprocessor Interrupt Enhancement - disabled
Nov  9 15:32:59 DB0CA kernel: [    0.757782] OTG VER PARAM: 0, OTG VER FLAG: 0
Nov  9 15:32:59 DB0CA kernel: [    0.760105] Dedicated Tx FIFOs mode
Nov  9 15:32:59 DB0CA kernel: [    0.762764] WARN::dwc_otg_hcd_init:1032: FIQ DMA bounce buffers: virt = 0xbad04000 dma = 0xfad04000 len=9024
Nov  9 15:32:59 DB0CA kernel: [    0.767670] FIQ FSM acceleration enabled for :
Nov  9 15:32:59 DB0CA kernel: [    0.767670] Non-periodic Split Transactions
Nov  9 15:32:59 DB0CA kernel: [    0.767670] Periodic Split Transactions
Nov  9 15:32:59 DB0CA kernel: [    0.767670] High-Speed Isochronous Endpoints
Nov  9 15:32:59 DB0CA kernel: [    0.767670] Interrupt/Control Split Transaction hack enabled
Nov  9 15:32:59 DB0CA kernel: [    0.779318] dwc_otg: Microframe scheduler enabled
Nov  9 15:32:59 DB0CA kernel: [    0.779368] WARN::hcd_init_fiq:459: FIQ on core 1 at 0x8058f5b0
Nov  9 15:32:59 DB0CA kernel: [    0.781679] WARN::hcd_init_fiq:460: FIQ ASM at 0x8058f920 length 36
Nov  9 15:32:59 DB0CA kernel: [    0.784009] WARN::hcd_init_fiq:486: MPHI regs_base at 0xbb87a000
Nov  9 15:32:59 DB0CA kernel: [    0.786364] dwc_otg 3f980000.usb: DWC OTG Controller
Nov  9 15:32:59 DB0CA kernel: [    0.788682] dwc_otg 3f980000.usb: new USB bus registered, assigned bus number 1
Nov  9 15:32:59 DB0CA kernel: [    0.791043] dwc_otg 3f980000.usb: irq 62, io mem 0x00000000
Nov  9 15:32:59 DB0CA kernel: [    0.793387] Init: Port Power? op_state=1
Nov  9 15:32:59 DB0CA kernel: [    0.795646] Init: Power Port (0)
Nov  9 15:32:59 DB0CA kernel: [    0.798031] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Nov  9 15:32:59 DB0CA kernel: [    0.800345] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Nov  9 15:32:59 DB0CA kernel: [    0.802670] usb usb1: Product: DWC OTG Controller
Nov  9 15:32:59 DB0CA kernel: [    0.804924] usb usb1: Manufacturer: Linux 4.9.59-v7+ dwc_otg_hcd
Nov  9 15:32:59 DB0CA kernel: [    0.807199] usb usb1: SerialNumber: 3f980000.usb
Nov  9 15:32:59 DB0CA kernel: [    0.810263] hub 1-0:1.0: USB hub found
Nov  9 15:32:59 DB0CA kernel: [    0.812491] hub 1-0:1.0: 1 port detected
Nov  9 15:32:59 DB0CA kernel: [    0.815228] dwc_otg: FIQ enabled
Nov  9 15:32:59 DB0CA kernel: [    0.815232] dwc_otg: NAK holdoff enabled
Nov  9 15:32:59 DB0CA kernel: [    0.815236] dwc_otg: FIQ split-transaction FSM enabled
Nov  9 15:32:59 DB0CA kernel: [    0.815250] Module dwc_common_port init
Nov  9 15:32:59 DB0CA kernel: [    0.815486] usbcore: registered new interface driver usb-storage
Nov  9 15:32:59 DB0CA kernel: [    0.817856] mousedev: PS/2 mouse device common for all mice
Nov  9 15:32:59 DB0CA kernel: [    0.820985] bcm2835-wdt 3f100000.watchdog: Broadcom BCM2835 watchdog timer
Nov  9 15:32:59 DB0CA kernel: [    0.823537] bcm2835-cpufreq: min=600000 max=1200000
Nov  9 15:32:59 DB0CA kernel: [    0.826187] sdhci: Secure Digital Host Controller Interface driver
Nov  9 15:32:59 DB0CA kernel: [    0.828503] sdhci: Copyright(c) Pierre Ossman
Nov  9 15:32:59 DB0CA kernel: [    0.831031] sdhost-bcm2835 3f202000.sdhost: could not get clk, deferring probe
Nov  9 15:32:59 DB0CA kernel: [    0.835623] mmc-bcm2835 3f300000.mmc: could not get clk, deferring probe
Nov  9 15:32:59 DB0CA kernel: [    0.838170] sdhci-pltfm: SDHCI platform and OF driver helper
Nov  9 15:32:59 DB0CA kernel: [    0.843215] ledtrig-cpu: registered to indicate activity on CPUs
Nov  9 15:32:59 DB0CA kernel: [    0.845868] hidraw: raw HID events driver (C) Jiri Kosina
Nov  9 15:32:59 DB0CA kernel: [    0.848540] usbcore: registered new interface driver usbhid
Nov  9 15:32:59 DB0CA kernel: [    0.851003] usbhid: USB HID core driver
Nov  9 15:32:59 DB0CA kernel: [    0.854269] vchiq: vchiq_init_state: slot_zero = 0xbad80000, is_master = 0
Nov  9 15:32:59 DB0CA kernel: [    0.858122] [vc_sm_connected_init]: start
Nov  9 15:32:59 DB0CA kernel: [    0.866819] [vc_sm_connected_init]: end - returning 0
Nov  9 15:32:59 DB0CA kernel: [    0.869637] Initializing XFRM netlink socket
Nov  9 15:32:59 DB0CA kernel: [    0.872116] NET: Registered protocol family 17
Nov  9 15:32:59 DB0CA kernel: [    0.874657] Key type dns_resolver registered
Nov  9 15:32:59 DB0CA kernel: [    0.877499] Registering SWP/SWPB emulation handler
Nov  9 15:32:59 DB0CA kernel: [    0.880697] registered taskstats version 1
Nov  9 15:32:59 DB0CA kernel: [    0.889382] uart-pl011 3f201000.serial: cts_event_workaround enabled
Nov  9 15:32:59 DB0CA kernel: [    0.891990] 3f201000.serial: ttyAMA0 at MMIO 0x3f201000 (irq = 87, base_baud = 0) is a PL011 rev2
Nov  9 15:32:59 DB0CA kernel: [    0.898494] sdhost: log_buf @ bad07000 (fad07000)
Nov  9 15:32:59 DB0CA kernel: [    0.981269] mmc0: sdhost-bcm2835 loaded - DMA enabled (>1)
Nov  9 15:32:59 DB0CA kernel: [    0.985995] mmc-bcm2835 3f300000.mmc: mmc_debug:0 mmc_debug2:0
Nov  9 15:32:59 DB0CA kernel: [    0.988489] mmc-bcm2835 3f300000.mmc: DMA channel allocated
Nov  9 15:32:59 DB0CA kernel: [    1.031334] Indeed it is in host mode hprt0 = 00021501
Nov  9 15:32:59 DB0CA kernel: [    1.121382] of_cfs_init
Nov  9 15:32:59 DB0CA kernel: [    1.123776] of_cfs_init: OK
Nov  9 15:32:59 DB0CA kernel: [    1.126456] Waiting for root device PARTUUID=2d256df5-02...
Nov  9 15:32:59 DB0CA kernel: [    1.139361] mmc1: queuing unknown CIS tuple 0x80 (2 bytes)
Nov  9 15:32:59 DB0CA kernel: [    1.143203] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Nov  9 15:32:59 DB0CA kernel: [    1.146903] mmc1: queuing unknown CIS tuple 0x80 (3 bytes)
Nov  9 15:32:59 DB0CA kernel: [    1.151729] mmc1: queuing unknown CIS tuple 0x80 (7 bytes)
Nov  9 15:32:59 DB0CA kernel: [    1.164097] mmc0: host does not support reading read-only switch, assuming write-enable
Nov  9 15:32:59 DB0CA kernel: [    1.171026] mmc0: new high speed SDHC card at address aaaa
Nov  9 15:32:59 DB0CA kernel: [    1.173873] mmcblk0: mmc0:aaaa SL16G 14.8 GiB
Nov  9 15:32:59 DB0CA kernel: [    1.178784]  mmcblk0: p1 p2
Nov  9 15:32:59 DB0CA kernel: [    1.187112] random: fast init done
Nov  9 15:32:59 DB0CA kernel: [    1.231267] usb 1-1: new full-speed USB device number 2 using dwc_otg
Nov  9 15:32:59 DB0CA kernel: [    1.233541] Indeed it is in host mode hprt0 = 00021501
Nov  9 15:32:59 DB0CA kernel: [    1.245616] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
Nov  9 15:32:59 DB0CA kernel: [    1.247756] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
Nov  9 15:32:59 DB0CA kernel: [    1.324093] mmc1: new high speed SDIO card at address 0001
Nov  9 15:32:59 DB0CA kernel: [    1.461502] usb 1-1: not running at top speed; connect to a high speed hub
Nov  9 15:32:59 DB0CA kernel: [    1.464008] usb 1-1: New USB device found, idVendor=0424, idProduct=9514
Nov  9 15:32:59 DB0CA kernel: [    1.466248] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Nov  9 15:32:59 DB0CA kernel: [    1.469303] hub 1-1:1.0: USB hub found
Nov  9 15:32:59 DB0CA kernel: [    1.471715] hub 1-1:1.0: 5 ports detected
Nov  9 15:32:59 DB0CA kernel: [    1.567156] EXT4-fs (mmcblk0p2): recovery complete
Nov  9 15:32:59 DB0CA kernel: [    1.571674] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Nov  9 15:32:59 DB0CA kernel: [    1.576414] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Nov  9 15:32:59 DB0CA kernel: [    1.586765] devtmpfs: mounted
Nov  9 15:32:59 DB0CA kernel: [    1.591066] Freeing unused kernel memory: 1024K
Nov  9 15:32:59 DB0CA kernel: [    1.791292] usb 1-1.1: new full-speed USB device number 3 using dwc_otg
Nov  9 15:32:59 DB0CA kernel: [    1.921556] usb 1-1.1: not running at top speed; connect to a high speed hub
Nov  9 15:32:59 DB0CA kernel: [    1.924464] usb 1-1.1: New USB device found, idVendor=0424, idProduct=ec00
Nov  9 15:32:59 DB0CA kernel: [    1.927098] usb 1-1.1: New USB device strings: Mfr=0, Product=0, SerialNumber=0
Nov  9 15:32:59 DB0CA kernel: [    1.932670] smsc95xx v1.0.5
Nov  9 15:32:59 DB0CA kernel: [    2.026097] smsc95xx 1-1.1:1.0 eth0: register 'smsc95xx' at usb-3f980000.usb-1.1, smsc95xx USB 2.0 Ethernet, b8:27:eb:90:0a:89
Nov  9 15:32:59 DB0CA kernel: [    2.131327] usb 1-1.2: new full-speed USB device number 4 using dwc_otg
Nov  9 15:32:59 DB0CA kernel: [    2.138153] NET: Registered protocol family 10
Nov  9 15:32:59 DB0CA kernel: [    2.154053] ip_tables: (C) 2000-2006 Netfilter Core Team
Nov  9 15:32:59 DB0CA kernel: [    2.262445] usb 1-1.2: New USB device found, idVendor=0d8c, idProduct=000c
Nov  9 15:32:59 DB0CA kernel: [    2.265789] usb 1-1.2: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Nov  9 15:32:59 DB0CA kernel: [    2.268719] usb 1-1.2: Product: C-Media USB Headphone Set  
Nov  9 15:32:59 DB0CA kernel: [    2.285217] input: C-Media USB Headphone Set   as /devices/platform/soc/3f980000.usb/usb1/1-1/1-1.2/1-1.2:1.3/0003:0D8C:000C.0001/input/input0
Nov  9 15:32:59 DB0CA kernel: [    2.361582] hid-generic 0003:0D8C:000C.0001: input,hidraw0: USB HID v1.00 Device [C-Media USB Headphone Set  ] on usb-3f980000.usb-1.2/input3
Nov  9 15:32:59 DB0CA kernel: [    3.275692] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Nov  9 15:32:59 DB0CA kernel: [    3.802723] gpiomem-bcm2835 3f200000.gpiomem: Initialised: Registers at 0x3f200000
Nov  9 15:32:59 DB0CA kernel: [    4.132168] brcmfmac: F1 signature read @0x18000000=0x1541a9a6
Nov  9 15:32:59 DB0CA kernel: [    4.140541] usbcore: registered new interface driver brcmfmac
Nov  9 15:32:59 DB0CA kernel: [    4.194155] usbcore: registered new interface driver snd-usb-audio
Nov  9 15:32:59 DB0CA kernel: [    4.371164] brcmfmac: Firmware version = wl0: Aug  7 2017 00:46:29 version 7.45.41.46 (r666254 CY) FWID 01-f8a78378
Nov  9 15:32:59 DB0CA kernel: [    4.372289] brcmfmac: brcmf_c_preinit_dcmds: CLM version = API: 12.2 Data: 7.11.15 Compiler: 1.24.2 ClmImport: 1.24.1 Creation: 2014-05-26 10:53:55 Inc Data: 9.10.41 Inc Compiler: 1.29.4 Inc ClmImport: 1.36.3 Creation: 2017-08-07 00:37:47 
Nov  9 15:32:59 DB0CA kernel: [    5.467804] uart-pl011 3f201000.serial: no DMA platform data
Nov  9 15:32:59 DB0CA kernel: [    6.061289] IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready
Nov  9 15:32:59 DB0CA kernel: [    6.061342] brcmfmac: power management disabled
Nov  9 15:33:00 DB0CA kernel: [    6.484396] smsc95xx 1-1.1:1.0 eth0: hardware isn't capable of remote wakeup
Nov  9 15:33:00 DB0CA kernel: [    6.484593] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Nov  9 15:33:00 DB0CA kernel: [    7.039475] IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready
Nov  9 15:33:03 DB0CA kernel: [    9.959349] Bluetooth: Core ver 2.22
Nov  9 15:33:03 DB0CA kernel: [    9.959433] NET: Registered protocol family 31
Nov  9 15:33:03 DB0CA kernel: [    9.959438] Bluetooth: HCI device and connection manager initialized
Nov  9 15:33:03 DB0CA kernel: [    9.959457] Bluetooth: HCI socket layer initialized
Nov  9 15:33:03 DB0CA kernel: [    9.959470] Bluetooth: L2CAP socket layer initialized
Nov  9 15:33:03 DB0CA kernel: [    9.959501] Bluetooth: SCO socket layer initialized
Nov  9 15:33:03 DB0CA kernel: [    9.969464] Bluetooth: HCI UART driver ver 2.3
Nov  9 15:33:03 DB0CA kernel: [    9.969482] Bluetooth: HCI UART protocol H4 registered
Nov  9 15:33:03 DB0CA kernel: [    9.969493] Bluetooth: HCI UART protocol Three-wire (H5) registered
Nov  9 15:33:03 DB0CA kernel: [    9.969692] Bluetooth: HCI UART protocol Broadcom registered
Nov  9 15:33:03 DB0CA kernel: [   10.139203] Bluetooth: BNEP (Ethernet Emulation) ver 1.3
Nov  9 15:33:03 DB0CA kernel: [   10.139210] Bluetooth: BNEP filters: protocol multicast
Nov  9 15:33:03 DB0CA kernel: [   10.139223] Bluetooth: BNEP socket layer initialized
Nov  9 15:33:15 DB0CA kernel: [   22.063744] random: crng init done

[P33M]

The OOM kill backtrace is unlikely to be related to the OTG speed parameter. Do you have any other settings in config.txt or cmdline.txt that are not standard?

[dl1esk]

only this one.... on my raspberry Pi2 i could use that Parameter in combination with the svxlink software, there i had some Audio Dropouts sometimes but no out of Memory and Kernel oops... the rest in my cmdline.txt is standard... I want to use that because when i use Usb 2.0 i have a much bigger Audio Delay from Soundcard Input to Soundcard Output via the svxlink Software... With Usb 1.1 i have no Delay...

[dl1esk]

and this happens only when i use the OTG Speed Parameter

[P33M]

The only bearing the dwc_otg driver could have on a crash like this would either be

• Memory corruption, writing to out-of-bounds locations
• Subtly altering timing such that a different bug is exposed elsewhere in the kernel

What happens if you add the parameter dwc_otg.fiq_fsm_enable=0 to cmdline.txt (and reboot)?

[dl1esk]

with the OTG Speed parameter on ?

[P33M]

Yes, with dwc_otg.speed=1.

[dl1esk]

atm the Oops Message doesnt happen agn in combination dwc_otg.fiq_fsm_enable=0 & dwc_otg.speed=1 i will observe the system now for 24Hrs to see if it happens agn or not but atm everything is fine now.

[dl1esk]

Just for u to understand what Svxlink does... the Mic Input is opened the whole Time... and the Earphone Output or Speaker Output is just opened when there is a Speech signal on the input, so the output is switched on/off many times while the input is open the whole time

[dl1esk]

@P33M in this combination it works well..... do u have an Idea what the problem is ?! i observed that sometimes when the Output ( earphone/ speaker ) be opened to send audio through that the first 5-10 secs or more dont come through. That just happens sometimes...but will be interesting why that happens because after that time the audio comes through and everything is fine.

[P33M]

I think I know what might be causing issues in full-speed mode. The frame counter in FS mode increments every 1ms, whereas in high-speed mode it increments every 125uS. There are certain paths in the FIQ and dwc_otg driver that make the assumption we're in high-speed mode when a delay is necessary, those delays are not valid anyway when in FS mode - the FIQ code is more or less redundant, aside from suppressing unnecessary SOF interrupts.

As a definitive test, does it fail to crash with dwc_otg.fiq_fsm_mask=0xB?

[dl1esk]

That u dont misunderstand me.... With USB 2.0 ( Sound Card Chip can only 1.1 ) i have a Delay between Input<>svxlink<>output Its an amateur radio repeater, the voice what comes over the input is routed directly to the output. the output pipe will be opened / closed after every conversation participant, then opened agn when the next one is speaking. With USB 1.1(dwc_otg.speed=1 )i have NO delay but sometimes when somebody starts speaking the first 5-10 secs are gone won`t be routed to the output, the output hangs then. After that time everything resumes to normal operation... I will try that Feature now and give u the result when i tested it. tnx for your help...

[dl1esk]

dwc_otg.fiq_fsm_mask=0xB & dwc_otg.speed=1 is running now since 3 hrs without any Crash... what is dwc_otg.fiq_fsm_mask=0xB for ?!

[P33M]

The FSM mask is a bitfield that controls which types of USB transfers are handled by the FIQ code.

Negating bit 2 means that Isochronous transfers are not performed by the FIQ code - which, as it produces a different result - implies that there is a bug somewhere in that codepath in combination with dwc_otg.speed=1.

What's the reason for using speed=1? Is it just that the delay between opening the USB sound card output and the first sound being played is unacceptable?

[dl1esk]

Yes the delay is too big sometimes ..,.that when u speak over the Repeater and stop talking, so the radio switches to rx ...then u can hear ur last spoken word >1000ms that happens not everytime but very often... and i also have the feeling that since i use the raspi 3...with Usb 2.0 sometimes some words get lost...seems that something get synced to the right time and then one word or some letters are lost.... and with using speed=1 it happens like described that sometimes one speaking passage get lost, just when the signal comes to close audio pipe from the program u can hear 1-2 letters from that passage...dunno why but no audio delay...

[dl1esk]

@P33M any Ideas?

[P33M]

Your initial issue describes a crash with dwc_otg.speed=1. Changing a setting makes the crash go away (so there is a bug in the FIQ code being suppressed) but aside from the general lack of network performance, what else is the issue with dwc_otg.speed=1?

[dl1esk]

That sometimes Audio got lost for one troughput.. pipe open no audio..pipe closed u get a few ms of the spoken Audio... That happens not everytime but quite a lot... it seems that this happens when u open/close the pipe quickly

[aplocher]

Hello, I've had this Pi3 setup with Octoprint and MJPG-Streamer to handle 3d printing and cam streaming to monitor it remotely for many months. It was pretty out-of-date so last night I did a apt-get update / apt-get dist-upgrade and everything was seemingly working fine until about an hour ago I received a similar error with that "Internal error: Oops: 17 [#1] SMP ARM" message in my remote SSH terminal:

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033349] Internal error: Oops: 17 [#1] SMP ARM

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033723] Process mjpg_streamer (pid: 14663, stack limit = 0x9eaca210)

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033735] Stack: (0x9eacbd78 to 0x9eacc000)

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033747] bd60:                                                       000005b4 806d1930

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033770] bd80: 000206fc 9eacbe88 a66db840 000206fc 9eacbe34 9eacbda0 806d1950 806ce34c

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033787] bda0: 000005b4 9eacbe6c 9eacbdcc 9eacbdb8 80c069c4 80d0a08c 80c049c0 9eaca020

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033804] bdc0: 00000000 9eacbdd0 00000000 00000000 00000001 00000000 9eacbe04 00000200

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033820] bde0: 9eacbe90 a66db990 000005b4 00000000 00000000 000005b4 7fffffff 9eacbe08

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033837] be00: 801235c4 801e0000 a66db840 a66db840 0003e764 9eacbe88 00000000 9eacbf08

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033853] be20: a6517600 00000000 9eacbe54 9eacbe38 806d247c 806d1654 806d2444 a66db840

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033870] be40: 00000000 00000000 9eacbe74 9eacbe58 806fe570 806d2450 00000001 9eacbe84

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033889] be60: 9eacbef0 00000000 9eacbe84 9eacbe78 80657c84 806fe534 9eacbedc 9eacbe88

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033906] be80: 80657d2c 80657c6c 00000000 00000000 00000001 000206fc 0001e068 9eacbee8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033922] bea0: 00000001 00400040 00000000 00000000 00000000 9eacbf08 a6517600 9eacbf80

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033939] bec0: 00000000 00000000 0003e764 9eaca000 9eacbf4c 9eacbee0 8028a930 80657ca0

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033955] bee0: 0003e764 00000006 75002008 0003e764 00000001 00000000 0003e764 9eacbee8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033971] bf00: 00000001 00400040 a6517600 00000000 00000000 00000000 00000000 00000000

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033987] bf20: 00000000 00000000 a6517600 0003e764 a6517600 75002008 9eacbf80 80108224

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034007] bf40: 9eacbf7c 9eacbf50 8028ab50 8028a85c 802aa234 802a9a10 a6517600 a6517601

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034024] bf60: 0003e764 75002008 80108224 9eaca000 9eacbfa4 9eacbf80 8028ada0 8028aaa8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034040] bf80: 00000000 00000000 00023120 0003e764 74efe0e8 00000004 00000000 9eacbfa8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034057] bfa0: 80108080 8028ad58 00023120 0003e764 00000007 75002008 0003e764 00000000

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034074] bfc0: 00023120 0003e764 74efe0e8 00000004 74efe530 76f0a24c 00000138 00040f57

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034090] bfe0: 00000000 74efe0b8 00000000 76ed9314 80000010 00000007 00000000 00000000

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034320] Code: e155000c 03a05000 e2117902 1a000039 (e5d50028)
Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033349] Internal error: Oops: 17 [#1] SMP ARM

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033723] Process mjpg_streamer (pid: 14663, stack limit = 0x9eaca210)

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033735] Stack: (0x9eacbd78 to 0x9eacc000)

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033747] bd60:                                                       000005b4 806d1930

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033770] bd80: 000206fc 9eacbe88 a66db840 000206fc 9eacbe34 9eacbda0 806d1950 806ce34c

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033787] bda0: 000005b4 9eacbe6c 9eacbdcc 9eacbdb8 80c069c4 80d0a08c 80c049c0 9eaca020

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033804] bdc0: 00000000 9eacbdd0 00000000 00000000 00000001 00000000 9eacbe04 00000200

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033820] bde0: 9eacbe90 a66db990 000005b4 00000000 00000000 000005b4 7fffffff 9eacbe08

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033837] be00: 801235c4 801e0000 a66db840 a66db840 0003e764 9eacbe88 00000000 9eacbf08

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033853] be20: a6517600 00000000 9eacbe54 9eacbe38 806d247c 806d1654 806d2444 a66db840

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033870] be40: 00000000 00000000 9eacbe74 9eacbe58 806fe570 806d2450 00000001 9eacbe84

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033889] be60: 9eacbef0 00000000 9eacbe84 9eacbe78 80657c84 806fe534 9eacbedc 9eacbe88

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033906] be80: 80657d2c 80657c6c 00000000 00000000 00000001 000206fc 0001e068 9eacbee8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033922] bea0: 00000001 00400040 00000000 00000000 00000000 9eacbf08 a6517600 9eacbf80

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033939] bec0: 00000000 00000000 0003e764 9eaca000 9eacbf4c 9eacbee0 8028a930 80657ca0

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033955] bee0: 0003e764 00000006 75002008 0003e764 00000001 00000000 0003e764 9eacbee8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033971] bf00: 00000001 00400040 a6517600 00000000 00000000 00000000 00000000 00000000

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.033987] bf20: 00000000 00000000 a6517600 0003e764 a6517600 75002008 9eacbf80 80108224

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034007] bf40: 9eacbf7c 9eacbf50 8028ab50 8028a85c 802aa234 802a9a10 a6517600 a6517601

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034024] bf60: 0003e764 75002008 80108224 9eaca000 9eacbfa4 9eacbf80 8028ada0 8028aaa8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034040] bf80: 00000000 00000000 00023120 0003e764 74efe0e8 00000004 00000000 9eacbfa8

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034057] bfa0: 80108080 8028ad58 00023120 0003e764 00000007 75002008 0003e764 00000000

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034074] bfc0: 00023120 0003e764 74efe0e8 00000004 74efe530 76f0a24c 00000138 00040f57

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034090] bfe0: 00000000 74efe0b8 00000000 76ed9314 80000010 00000007 00000000 00000000

Message from syslogd@BC-REPRAP-01 at Apr 18 04:46:09 ...
 kernel:[13872.034320] Code: e155000c 03a05000 e2117902 1a000039 (e5d50028)

My syslog:

Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033285] Unable to handle kernel NULL pointer dereference at virtual address 00000028
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033309] pgd = af2d4000
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033320] [00000028] *pgd=2f3d3835, *pte=00000000, *ppte=00000000
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033349] Internal error: Oops: 17 [#1] SMP ARM
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033363] Modules linked in: fuse rfcomm cmac bnep hci_uart bluetooth ecdh_generic evdev brcmfmac brcmutil ch341 usbserial cfg80211 rfkill w1_therm w1_gpio uvcvideo wire snd_usb_audio cn hwmon videobuf2_vmalloc snd_hwdep videobuf2_memops snd_usbmidi_lib videobuf2_v4l2 snd_rawmidi uio_pdrv_genirq snd_seq_device fixed uio snd_pcm videobuf2_core snd_timer videodev snd media i2c_dev ip_tables x_tables ipv6
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033569] CPU: 1 PID: 14663 Comm: mjpg_streamer Not tainted 4.14.30-v7+ #1102
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033578] Hardware name: BCM2835
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033589] task: 9ea1ad00 task.stack: 9eaca000
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033611] PC is at tcp_push+0x44/0x148
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033630] LR is at tcp_sendmsg_locked+0x308/0xdfc
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033642] pc : [<806ce384>]    lr : [<806d1950>]    psr: 40000013
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033652] sp : 9eacbd78  ip : a66db93c  fp : 9eacbd9c
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033665] r10: a6741380  r9 : ffffffe0  r8 : a66db93c
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033676] r7 : 00000000  r6 : 000005b4  r5 : 00000000  r4 : a66db840
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033688] r3 : 00000000  r2 : 000005b4  r1 : 00000000  r0 : b2235380
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033700] Flags: nZcv  IRQs on  FIQs on  Mode SVC_32  ISA ARM  Segment user
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033712] Control: 10c5383d  Table: 2f2d406a  DAC: 00000055
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033723] Process mjpg_streamer (pid: 14663, stack limit = 0x9eaca210)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033735] Stack: (0x9eacbd78 to 0x9eacc000)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033747] bd60:                                                       000005b4 806d1930
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033770] bd80: 000206fc 9eacbe88 a66db840 000206fc 9eacbe34 9eacbda0 806d1950 806ce34c
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033787] bda0: 000005b4 9eacbe6c 9eacbdcc 9eacbdb8 80c069c4 80d0a08c 80c049c0 9eaca020
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033804] bdc0: 00000000 9eacbdd0 00000000 00000000 00000001 00000000 9eacbe04 00000200
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033820] bde0: 9eacbe90 a66db990 000005b4 00000000 00000000 000005b4 7fffffff 9eacbe08
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033837] be00: 801235c4 801e0000 a66db840 a66db840 0003e764 9eacbe88 00000000 9eacbf08
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033853] be20: a6517600 00000000 9eacbe54 9eacbe38 806d247c 806d1654 806d2444 a66db840
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033870] be40: 00000000 00000000 9eacbe74 9eacbe58 806fe570 806d2450 00000001 9eacbe84
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033889] be60: 9eacbef0 00000000 9eacbe84 9eacbe78 80657c84 806fe534 9eacbedc 9eacbe88
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033906] be80: 80657d2c 80657c6c 00000000 00000000 00000001 000206fc 0001e068 9eacbee8
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033922] bea0: 00000001 00400040 00000000 00000000 00000000 9eacbf08 a6517600 9eacbf80
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033939] bec0: 00000000 00000000 0003e764 9eaca000 9eacbf4c 9eacbee0 8028a930 80657ca0
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033955] bee0: 0003e764 00000006 75002008 0003e764 00000001 00000000 0003e764 9eacbee8
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033971] bf00: 00000001 00400040 a6517600 00000000 00000000 00000000 00000000 00000000
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.033987] bf20: 00000000 00000000 a6517600 0003e764 a6517600 75002008 9eacbf80 80108224
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034007] bf40: 9eacbf7c 9eacbf50 8028ab50 8028a85c 802aa234 802a9a10 a6517600 a6517601
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034024] bf60: 0003e764 75002008 80108224 9eaca000 9eacbfa4 9eacbf80 8028ada0 8028aaa8
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034040] bf80: 00000000 00000000 00023120 0003e764 74efe0e8 00000004 00000000 9eacbfa8
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034057] bfa0: 80108080 8028ad58 00023120 0003e764 00000007 75002008 0003e764 00000000
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034074] bfc0: 00023120 0003e764 74efe0e8 00000004 74efe530 76f0a24c 00000138 00040f57
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034090] bfe0: 00000000 74efe0b8 00000000 76ed9314 80000010 00000007 00000000 00000000
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034119] [<806ce384>] (tcp_push) from [<806d1950>] (tcp_sendmsg_locked+0x308/0xdfc)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034144] [<806d1950>] (tcp_sendmsg_locked) from [<806d247c>] (tcp_sendmsg+0x38/0x4c)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034167] [<806d247c>] (tcp_sendmsg) from [<806fe570>] (inet_sendmsg+0x48/0xe4)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034190] [<806fe570>] (inet_sendmsg) from [<80657c84>] (sock_sendmsg+0x24/0x34)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034211] [<80657c84>] (sock_sendmsg) from [<80657d2c>] (sock_write_iter+0x98/0xcc)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034233] [<80657d2c>] (sock_write_iter) from [<8028a930>] (__vfs_write+0xe0/0x138)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034259] [<8028a930>] (__vfs_write) from [<8028ab50>] (vfs_write+0xb4/0x1bc)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034279] [<8028ab50>] (vfs_write) from [<8028ada0>] (SyS_write+0x54/0xb0)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034301] [<8028ada0>] (SyS_write) from [<80108080>] (ret_fast_syscall+0x0/0x28)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034320] Code: e155000c 03a05000 e2117902 1a000039 (e5d50028)
Apr 18 04:46:09 BC-REPRAP-01 kernel: [13872.034335] ---[ end trace 4fafc113ac0136da ]---

I don't seem to have dwc_otg.speed=1

When I did the apt-get, I believe I saw it say it was replacing the January rpi kernel (201801??) with March's (201803??) if that helps. I don't recall if I was on a 4.9 kernel previously, but I'm guessing I was (if that was the kernel in January). Whatever is causing it seems to be related to the update I did.

Thanks

[pelwell]

We have today pushed an update to the Raspbian kernel package that includes a fix for this upstream TCP bug, so if you update and upgrade again you should no longer get this Oops.

[aplocher]

You guys are on it! You rock thanks. Updating now and will report back if I see this again.

[JamesH65]

@aplocher Anything to report? If now ok, please close the issue.

This issue will be closed within 30 days unless further interactions are posted. If you wish this issue to remain open, please add a comment. A closed issue may be reopened if requested.

[aplocher]

Sorry about that, the update fixed everything. As stated previously, you guys rock 👍

But I'm not the originator of this issue, so I can't close it.

[JamesH65]

I can!! Bwahahahahahahah etc