Skip to content
New issue

Have a question about this project? Sign up for a free GitHub account to open an issue and contact its maintainers and the community.

By clicking “Sign up for GitHub”, you agree to our terms of service and privacy statement. We’ll occasionally send you account related emails.

Already on GitHub? Sign in to your account

system freeze while unplug r8152 usb2network card #1219

Closed
huangjiansword opened this issue Dec 8, 2015 · 25 comments
Closed

system freeze while unplug r8152 usb2network card #1219

huangjiansword opened this issue Dec 8, 2015 · 25 comments

Comments

@huangjiansword
Copy link

hi there,
I have a raspberry pi model A+ running linux 3.18.7+, and raspberry pi B running linux 4.1.7.I found a issue about r8152 driver in the image.

steps below:
1, attach a usb hub(self-powered usb hub is better, otherwise the pi'll reboot when you plug usb2network in) on the pi's usb port
2, attach a usb2network card (chip ID is 0bda:8152 Realtek Semiconductor Corp.) device on the usb hub
3, connect network wire to r8152 network card and a router
4, run ifconfig to monitor eth0's status(eth1 in raspberry model B, which is the usb2network's ethnet port)
5, when eth0's status changed to running or got ip address, unplug the r8152 device, the raspberry pi has a large probability to stop response
you may try serveral times to reappear this issue.

I use several other usb2network cards(chip ID is 0b95:772b ASIX Electronics Corp. and ), the same operation, It works, no crash.

BTW, I try the latest driver 2.05.0 from realteck website, problem remains.

My power supply is 5V 2A, the power is good enough for raspberry pi.

I don't think the freeze is related with the usb hub, I tried many hub chip such as 05e3:0608(GL850G) or 05e3:0610(GL852G) from Genesys logic or 1a40:0101or 1a40:0201 Terminus Technology Inc. or 0424:9512 from Standard Microsystems Corp. which is the original hub of raspberry model B

And I can not get any related log from dmesg or other log.

If attached the r8152 directly with the Pi's USB port, no such issue.

I have contacted with the engineer of REALTEK, the conclusion from REALTEK is:
"If hub is involved to the issue, it could be a timing compatibility issue between usb host controller and genesis chip."

How can I fix the issue?
Thank you in advance!

@huangjiansword
Copy link
Author

I can reappear the issue with Raspberry A+ and Raspberry B with image 4.1.7 and 3.18.7
Linux raspberrypi 4.1.7+ #817 PREEMPT Sat Sep 19 15:25:36 BST 2015 armv6l GNU/Li nux

Linux raspberrypi 3.18.7+ #4 PREEMPT Mon May 11 15:39:01 CST 2015 armv6l GNU/Linux

@popcornmix
Copy link
Collaborator

Do you get a kernel panic/backtrace output to display?

@huangjiansword
Copy link
Author

no, I got nothing display and nothing valuable information in dmesg or messages or other log, the system just lost response.

@popcornmix
Copy link
Collaborator

Can you explain exactly what you see?
Are you starting from initial console (i.e. not desktop).
Are you interacting with keyboard/display?
After the crash does the display appears exactly as it did before or does it blank?

@huangjiansword
Copy link
Author

this is the log from messages, it records the hang & reboot process, but no any information related with the hang reason


Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Booting Linux on physical CPU 0x0
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Initializing cgroup subsys cpuset
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Initializing cgroup subsys cpu
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Initializing cgroup subsys cpuacct
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Linux version 4.1.7+ (dc4@dc4-XPS13-9333) (gcc version 4.8.3 20140303 (prerelease) (crosstool-NG linaro-1.13.1+bzr2650 - Linaro GCC 2014.03) ) #817 PREEMPT Sat Sep 19 15:25:36 BST 2015
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Machine model: Raspberry Pi Model A Plus Rev 1.1
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] cma: Reserved 8 MiB at 0x0b800000
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Memory policy: Data cache writeback
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 48720
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=1824 bcm2708_fb.fbheight=984 bcm2708.boardrev=0x12 bcm2708.serial=0xf992ca04 smsc95xx.macaddr=B8:27:EB:92:CA:04 bcm2708_fb.fbswap=1 bcm2708.disk_led_gpio=47 bcm2708.disk_led_active_low=0 sdhci-bcm2708.emmc_clock_freq=250000000 vc_mem.mem_base=0xec00000 vc_mem.mem_size=0x10000000  dwc_otg.lpm_enable=0 console=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Memory: 176864K/196608K available (6132K kernel code, 490K rwdata, 1780K rodata, 348K init, 720K bss, 11552K reserved, 8192K cma-reserved)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Virtual kernel memory layout:
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]     vmalloc : 0xcc800000 - 0xff000000   ( 808 MB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]     lowmem  : 0xc0000000 - 0xcc000000   ( 192 MB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]     modules : 0xbf000000 - 0xc0000000   (  16 MB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]       .text : 0xc0008000 - 0xc07c23ec   (7913 kB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]       .init : 0xc07c3000 - 0xc081a000   ( 348 kB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]       .data : 0xc081a000 - 0xc0894824   ( 491 kB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]        .bss : 0xc0894824 - 0xc09489b0   ( 721 kB)
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] Preemptible hierarchical RCU implementation.
Dec  8 07:17:32 raspberrypi kernel: [    0.000000]      Additional per-CPU info printed with stalls.
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] NR_IRQS:522
Dec  8 07:17:32 raspberrypi kernel: [    0.000000] clocksource stc: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Dec  8 07:17:32 raspberrypi kernel: [    0.000014] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Dec  8 07:17:32 raspberrypi kernel: [    0.000056] Switching to timer-based delay loop, resolution 1000ns
Dec  8 07:17:32 raspberrypi kernel: [    0.000337] Console: colour dummy device 80x30
Dec  8 07:17:32 raspberrypi kernel: [    0.001762] console [tty1] enabled
Dec  8 07:17:32 raspberrypi kernel: [    0.001828] Calibrating delay loop (skipped), value calculated using timer frequency.. 2.00 BogoMIPS (lpj=10000)
Dec  8 07:17:32 raspberrypi kernel: [    0.001927] pid_max: default: 32768 minimum: 301
Dec  8 07:17:32 raspberrypi kernel: [    0.002288] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.002369] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.003448] Initializing cgroup subsys blkio
Dec  8 07:17:32 raspberrypi kernel: [    0.003547] Initializing cgroup subsys memory
Dec  8 07:17:32 raspberrypi kernel: [    0.003623] Initializing cgroup subsys devices
Dec  8 07:17:32 raspberrypi kernel: [    0.003690] Initializing cgroup subsys freezer
Dec  8 07:17:32 raspberrypi kernel: [    0.003755] Initializing cgroup subsys net_cls
Dec  8 07:17:32 raspberrypi kernel: [    0.003878] CPU: Testing write buffer coherency: ok
Dec  8 07:17:32 raspberrypi kernel: [    0.004005] ftrace: allocating 19773 entries in 58 pages
Dec  8 07:17:32 raspberrypi kernel: [    0.108885] Setting up static identity map for 0x81c0 - 0x81f8
Dec  8 07:17:32 raspberrypi kernel: [    0.111664] devtmpfs: initialized
Dec  8 07:17:32 raspberrypi kernel: [    0.122717] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Dec  8 07:17:32 raspberrypi kernel: [    0.123183] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Dec  8 07:17:32 raspberrypi kernel: [    0.125200] pinctrl core: initialized pinctrl subsystem
Dec  8 07:17:32 raspberrypi kernel: [    0.126152] NET: Registered protocol family 16
Dec  8 07:17:32 raspberrypi kernel: [    0.131747] DMA: preallocated 4096 KiB pool for atomic coherent allocations
Dec  8 07:17:32 raspberrypi kernel: [    0.133338] bcm2708.uart_clock = 3000000
Dec  8 07:17:32 raspberrypi kernel: [    0.138895] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Dec  8 07:17:32 raspberrypi kernel: [    0.138989] hw-breakpoint: maximum watchpoint size is 4 bytes.
Dec  8 07:17:32 raspberrypi kernel: [    0.139182] Serial: AMBA PL011 UART driver
Dec  8 07:17:32 raspberrypi kernel: [    0.139492] 20201000.uart: ttyAMA0 at MMIO 0x20201000 (irq = 83, base_baud = 0) is a PL011 rev2
Dec  8 07:17:32 raspberrypi kernel: [    0.528224] console [ttyAMA0] enabled
Dec  8 07:17:32 raspberrypi kernel: [    0.532629] bcm2835-mbox 2000b880.mailbox: mailbox enabled
Dec  8 07:17:32 raspberrypi kernel: [    0.600775] bcm2708-dmaengine 20007000.dma: DMA legacy API manager at f2007000, dmachans=0xf35
Dec  8 07:17:32 raspberrypi kernel: [    0.609665] bcm2708-dmaengine 20007000.dma: Initialized 7 DMA channels (+ 1 legacy)
Dec  8 07:17:32 raspberrypi kernel: [    0.618185] bcm2708-dmaengine 20007000.dma: Load BCM2835 DMA engine driver
Dec  8 07:17:32 raspberrypi kernel: [    0.625183] bcm2708-dmaengine 20007000.dma: dma_debug:0
Dec  8 07:17:32 raspberrypi kernel: [    0.631373] SCSI subsystem initialized
Dec  8 07:17:32 raspberrypi kernel: [    0.635601] usbcore: registered new interface driver usbfs
Dec  8 07:17:32 raspberrypi kernel: [    0.641261] usbcore: registered new interface driver hub
Dec  8 07:17:32 raspberrypi kernel: [    0.646855] usbcore: registered new device driver usb
Dec  8 07:17:32 raspberrypi kernel: [    0.652930] raspberrypi-firmware soc:firmware: Attached to firmware from 2015-09-23 12:12
Dec  8 07:17:32 raspberrypi kernel: [    0.688827] Switched to clocksource stc
Dec  8 07:17:32 raspberrypi kernel: [    0.740173] FS-Cache: Loaded
Dec  8 07:17:32 raspberrypi kernel: [    0.743499] CacheFiles: Loaded
Dec  8 07:17:32 raspberrypi kernel: [    0.763338] NET: Registered protocol family 2
Dec  8 07:17:32 raspberrypi kernel: [    0.769370] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.776452] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.783134] TCP: Hash tables configured (established 2048 bind 2048)
Dec  8 07:17:32 raspberrypi kernel: [    0.789706] UDP hash table entries: 256 (order: 0, 4096 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.795608] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.802375] NET: Registered protocol family 1
Dec  8 07:17:32 raspberrypi kernel: [    0.807400] RPC: Registered named UNIX socket transport module.
Dec  8 07:17:32 raspberrypi kernel: [    0.813527] RPC: Registered udp transport module.
Dec  8 07:17:32 raspberrypi kernel: [    0.818276] RPC: Registered tcp transport module.
Dec  8 07:17:32 raspberrypi kernel: [    0.823063] RPC: Registered tcp NFSv4.1 backchannel transport module.
Dec  8 07:17:32 raspberrypi kernel: [    0.830895] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
Dec  8 07:17:32 raspberrypi kernel: [    0.840203] futex hash table entries: 256 (order: -1, 3072 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.862745] VFS: Disk quotas dquot_6.6.0
Dec  8 07:17:32 raspberrypi kernel: [    0.867141] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Dec  8 07:17:32 raspberrypi kernel: [    0.876813] FS-Cache: Netfs 'nfs' registered for caching
Dec  8 07:17:32 raspberrypi kernel: [    0.883924] NFS: Registering the id_resolver key type
Dec  8 07:17:32 raspberrypi kernel: [    0.889289] Key type id_resolver registered
Dec  8 07:17:32 raspberrypi kernel: [    0.893523] Key type id_legacy registered
Dec  8 07:17:32 raspberrypi kernel: [    0.901559] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Dec  8 07:17:32 raspberrypi kernel: [    0.909660] io scheduler noop registered
Dec  8 07:17:32 raspberrypi kernel: [    0.913673] io scheduler deadline registered (default)
Dec  8 07:17:32 raspberrypi kernel: [    0.919429] io scheduler cfq registered
Dec  8 07:17:32 raspberrypi kernel: [    0.925773] BCM2708FB: allocated DMA memory 4bc00000
Dec  8 07:17:32 raspberrypi kernel: [    0.931136] BCM2708FB: allocated DMA channel 0 @ f2007000
Dec  8 07:17:32 raspberrypi kernel: [    0.960677] Console: switching to colour frame buffer device 228x61
Dec  8 07:17:32 raspberrypi kernel: [    0.985183] Serial: 8250/16550 driver, 0 ports, IRQ sharing disabled
Dec  8 07:17:32 raspberrypi kernel: [    0.993524] vc-cma: Videocore CMA driver
Dec  8 07:17:32 raspberrypi kernel: [    0.997588] vc-cma: vc_cma_base      = 0x00000000
Dec  8 07:17:32 raspberrypi kernel: [    1.002562] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
Dec  8 07:17:32 raspberrypi kernel: [    1.008091] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
Dec  8 07:17:32 raspberrypi kernel: [    1.014126] vc-mem: phys_addr:0x00000000 mem_base=0x0ec00000 mem_size:0x10000000(256 MiB)
Dec  8 07:17:32 raspberrypi kernel: [    1.043740] brd: module loaded
Dec  8 07:17:32 raspberrypi kernel: [    1.056808] loop: module loaded
Dec  8 07:17:32 raspberrypi kernel: [    1.061504] vchiq: vchiq_init_state: slot_zero = 0xcbc80000, is_master = 0
Dec  8 07:17:32 raspberrypi kernel: [    1.070853] Loading iSCSI transport class v2.0-870.
Dec  8 07:17:32 raspberrypi kernel: [    1.077492] usbcore: registered new interface driver smsc95xx
Dec  8 07:17:32 raspberrypi kernel: [    1.083801] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Dec  8 07:17:32 raspberrypi kernel: [    1.290147] Core Release: 2.80a
Dec  8 07:17:32 raspberrypi kernel: [    1.293418] Setting default values for core params
Dec  8 07:17:32 raspberrypi kernel: [    1.298358] Finished setting default values for core params
Dec  8 07:17:32 raspberrypi kernel: [    1.504387] Using Buffer DMA mode
Dec  8 07:17:32 raspberrypi kernel: [    1.507826] Periodic Transfer Interrupt Enhancement - disabled
Dec  8 07:17:32 raspberrypi kernel: [    1.513841] Multiprocessor Interrupt Enhancement - disabled
Dec  8 07:17:32 raspberrypi kernel: [    1.519592] OTG VER PARAM: 0, OTG VER FLAG: 0
Dec  8 07:17:32 raspberrypi kernel: [    1.524058] Dedicated Tx FIFOs mode
Dec  8 07:17:32 raspberrypi kernel: [    1.528109] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xcbc14000 dma = 0x4bc14000 len=9024
Dec  8 07:17:32 raspberrypi kernel: [    1.538260] FIQ FSM acceleration enabled for :
Dec  8 07:17:32 raspberrypi kernel: [    1.538260] Non-periodic Split Transactions
Dec  8 07:17:32 raspberrypi kernel: [    1.538260] Periodic Split Transactions
Dec  8 07:17:32 raspberrypi kernel: [    1.538260] High-Speed Isochronous Endpoints
Dec  8 07:17:32 raspberrypi kernel: [    1.555572] WARN::hcd_init_fiq:412: FIQ on core 0 at 0xc0423ab8
Dec  8 07:17:32 raspberrypi kernel: [    1.567002] WARN::hcd_init_fiq:413: FIQ ASM at 0xc0423d90 length 36
Dec  8 07:17:32 raspberrypi kernel: [    1.578535] WARN::hcd_init_fiq:438: MPHI regs_base at 0xcc896000
Dec  8 07:17:32 raspberrypi kernel: [    1.590071] dwc_otg 20980000.usb: DWC OTG Controller
Dec  8 07:17:32 raspberrypi kernel: [    1.600616] dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
Dec  8 07:17:32 raspberrypi kernel: [    1.613383] dwc_otg 20980000.usb: irq 32, io mem 0x00000000
Dec  8 07:17:32 raspberrypi kernel: [    1.624391] Init: Port Power? op_state=1
Dec  8 07:17:32 raspberrypi kernel: [    1.633708] Init: Power Port (0)
Dec  8 07:17:32 raspberrypi kernel: [    1.642554] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Dec  8 07:17:32 raspberrypi kernel: [    1.654821] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Dec  8 07:17:32 raspberrypi kernel: [    1.667478] usb usb1: Product: DWC OTG Controller
Dec  8 07:17:32 raspberrypi kernel: [    1.677476] usb usb1: Manufacturer: Linux 4.1.7+ dwc_otg_hcd
Dec  8 07:17:32 raspberrypi kernel: [    1.688591] usb usb1: SerialNumber: 20980000.usb
Dec  8 07:17:32 raspberrypi kernel: [    1.699867] hub 1-0:1.0: USB hub found
Dec  8 07:17:32 raspberrypi kernel: [    1.709232] hub 1-0:1.0: 1 port detected
Dec  8 07:17:32 raspberrypi kernel: [    1.719983] usbcore: registered new interface driver usb-storage
Dec  8 07:17:32 raspberrypi kernel: [    1.732109] mousedev: PS/2 mouse device common for all mice
Dec  8 07:17:32 raspberrypi kernel: [    1.744349] bcm2835-cpufreq: min=700000 max=700000
Dec  8 07:17:32 raspberrypi kernel: [    1.755240] sdhci: Secure Digital Host Controller Interface driver
Dec  8 07:17:32 raspberrypi kernel: [    1.766913] sdhci: Copyright(c) Pierre Ossman
Dec  8 07:17:32 raspberrypi kernel: [    1.777214] mmc-bcm2835 20300000.mmc: mmc_debug:0 mmc_debug2:0
Dec  8 07:17:32 raspberrypi kernel: [    1.788492] mmc-bcm2835 20300000.mmc: DMA channels allocated
Dec  8 07:17:32 raspberrypi kernel: [    1.839350] sdhci-pltfm: SDHCI platform and OF driver helper
Dec  8 07:17:32 raspberrypi kernel: [    1.859187] ledtrig-cpu: registered to indicate activity on CPUs
Dec  8 07:17:32 raspberrypi kernel: [    1.873160] hidraw: raw HID events driver (C) Jiri Kosina
Dec  8 07:17:32 raspberrypi kernel: [    1.888549] usbcore: registered new interface driver usbhid
Dec  8 07:17:32 raspberrypi kernel: [    1.900656] usbhid: USB HID core driver
Dec  8 07:17:32 raspberrypi kernel: [    1.910018] Indeed it is in host mode hprt0 = 00021501
Dec  8 07:17:32 raspberrypi kernel: [    1.924458] Initializing XFRM netlink socket
Dec  8 07:17:32 raspberrypi kernel: [    1.938990] NET: Registered protocol family 17
Dec  8 07:17:32 raspberrypi kernel: [    1.956657] mmc0: host does not support reading read-only switch, assuming write-enable
Dec  8 07:17:32 raspberrypi kernel: [    1.979087] Key type dns_resolver registered
Dec  8 07:17:32 raspberrypi kernel: [    2.001085] mmc0: new high speed SDHC card at address 1234
Dec  8 07:17:32 raspberrypi kernel: [    2.012219] registered taskstats version 1
Dec  8 07:17:32 raspberrypi kernel: [    2.029938] vc-sm: Videocore shared memory driver
Dec  8 07:17:32 raspberrypi kernel: [    2.040392] mmcblk0: mmc0:1234 SA08G 7.21 GiB
Dec  8 07:17:32 raspberrypi kernel: [    2.059974] [vc_sm_connected_init]: start
Dec  8 07:17:32 raspberrypi kernel: [    2.069754]  mmcblk0: p1 p2
Dec  8 07:17:32 raspberrypi kernel: [    2.092179] [vc_sm_connected_init]: end - returning 0
Dec  8 07:17:32 raspberrypi kernel: [    2.109517] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
Dec  8 07:17:32 raspberrypi kernel: [    2.122609] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
Dec  8 07:17:32 raspberrypi kernel: [    2.218954] usb 1-1: new high-speed USB device number 2 using dwc_otg
Dec  8 07:17:32 raspberrypi kernel: [    2.233348] Indeed it is in host mode hprt0 = 00001101
Dec  8 07:17:32 raspberrypi kernel: [    2.449681] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101
Dec  8 07:17:32 raspberrypi kernel: [    2.461977] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Dec  8 07:17:32 raspberrypi kernel: [    2.474668] usb 1-1: Product: USB 2.0 Hub [MTT]
Dec  8 07:17:32 raspberrypi kernel: [    2.485847] hub 1-1:1.0: USB hub found
Dec  8 07:17:32 raspberrypi kernel: [    2.495342] hub 1-1:1.0: 4 ports detected
Dec  8 07:17:32 raspberrypi kernel: [    2.778929] usb 1-1.4: new high-speed USB device number 3 using dwc_otg
Dec  8 07:17:32 raspberrypi kernel: [    2.889618] usb 1-1.4: New USB device found, idVendor=1a40, idProduct=0201
Dec  8 07:17:32 raspberrypi kernel: [    2.902089] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Dec  8 07:17:32 raspberrypi kernel: [    2.914757] usb 1-1.4: Product: USB 2.0 Hub [MTT]
Dec  8 07:17:32 raspberrypi kernel: [    2.925790] hub 1-1.4:1.0: USB hub found
Dec  8 07:17:32 raspberrypi kernel: [    2.935341] hub 1-1.4:1.0: 7 ports detected
Dec  8 07:17:32 raspberrypi kernel: [    7.366678] EXT4-fs (mmcblk0p2): orphan cleanup on readonly fs
Dec  8 07:17:32 raspberrypi kernel: [    7.378603] EXT4-fs (mmcblk0p2): 1 orphan inode deleted
Dec  8 07:17:32 raspberrypi kernel: [    7.389364] EXT4-fs (mmcblk0p2): recovery complete
Dec  8 07:17:32 raspberrypi kernel: [    9.037646] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Dec  8 07:17:32 raspberrypi kernel: [    9.051376] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Dec  8 07:17:32 raspberrypi kernel: [    9.064894] devtmpfs: mounted
Dec  8 07:17:32 raspberrypi kernel: [    9.074451] Freeing unused kernel memory: 348K (c07c3000 - c081a000)
Dec  8 07:17:32 raspberrypi kernel: [    9.461380] random: systemd urandom read with 81 bits of entropy available
Dec  8 07:17:32 raspberrypi kernel: [    9.696641] NET: Registered protocol family 10
Dec  8 07:17:32 raspberrypi kernel: [    9.876879] uart-pl011 20201000.uart: no DMA platform data
Dec  8 07:17:32 raspberrypi kernel: [   11.882415] fuse init (API version 7.23)
Dec  8 07:17:32 raspberrypi kernel: [   12.075710] i2c /dev entries driver
Dec  8 07:17:32 raspberrypi kernel: [   13.848984] random: nonblocking pool is initialized
Dec  8 07:17:32 raspberrypi kernel: [   15.646501] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
Dec  8 07:17:32 raspberrypi kernel: [   15.649990] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Dec  8 07:17:32 raspberrypi kernel: [   21.416138] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:32 raspberrypi kernel: [   23.971105] Adding 102396k swap on /var/swap.  Priority:-1 extents:5 across:573436k SSFS
Dec  8 07:17:32 raspberrypi kernel: [   24.569426] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:36 raspberrypi kernel: [   27.729050] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:39 raspberrypi kernel: [   30.889054] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:40 raspberrypi kernel: [   31.968945] usb 1-1.4.1: new full-speed USB device number 4 using dwc_otg
Dec  8 07:17:40 raspberrypi kernel: [   32.096801] usb 1-1.4.1: New USB device found, idVendor=046d, idProduct=c534
Dec  8 07:17:40 raspberrypi kernel: [   32.096917] usb 1-1.4.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Dec  8 07:17:40 raspberrypi kernel: [   32.096940] usb 1-1.4.1: Product: USB Receiver
Dec  8 07:17:40 raspberrypi kernel: [   32.096961] usb 1-1.4.1: Manufacturer: Logitech
Dec  8 07:17:40 raspberrypi kernel: [   32.129969] input: Logitech USB Receiver as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.4/1-1.4.1/1-1.4.1:1.0/0003:046D:C534.0001/input/input0
Dec  8 07:17:40 raspberrypi kernel: [   32.189562] hid-generic 0003:046D:C534.0001: input,hidraw0: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-20980000.usb-1.4.1/input0
Dec  8 07:17:40 raspberrypi kernel: [   32.227879] input: Logitech USB Receiver as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.4/1-1.4.1/1-1.4.1:1.1/0003:046D:C534.0002/input/input1
Dec  8 07:17:40 raspberrypi kernel: [   32.283200] hid-generic 0003:046D:C534.0002: input,hiddev0,hidraw1: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-20980000.usb-1.4.1/input1
Dec  8 07:17:42 raspberrypi kernel: [   34.048965] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:43 raspberrypi kernel: [   35.028949] usb 1-1.4.7: new high-speed USB device number 5 using dwc_otg
Dec  8 07:17:43 raspberrypi kernel: [   35.131018] usb 1-1.4.7: New USB device found, idVendor=0bda, idProduct=8152
Dec  8 07:17:43 raspberrypi kernel: [   35.131064] usb 1-1.4.7: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Dec  8 07:17:43 raspberrypi kernel: [   35.131084] usb 1-1.4.7: Product: USB 10/100 LAN
Dec  8 07:17:43 raspberrypi kernel: [   35.131102] usb 1-1.4.7: Manufacturer: Realtek
Dec  8 07:17:43 raspberrypi kernel: [   35.131120] usb 1-1.4.7: SerialNumber: 00E04C36123C
Dec  8 07:17:45 raspberrypi kernel: [   37.077085] usbcore: registered new interface driver r8152
Dec  8 07:17:45 raspberrypi kernel: [   37.096654] usbcore: registered new interface driver cdc_ether
Dec  8 07:17:45 raspberrypi kernel: [   37.169049] usb 1-1.4.7: reset high-speed USB device number 5 using dwc_otg
Dec  8 07:17:45 raspberrypi kernel: [   37.209075] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:45 raspberrypi kernel: [   37.333634] r8152 1-1.4.7:1.0 eth0: v1.08.0 (2015/01/13)
Dec  8 07:17:46 raspberrypi kernel: [   37.699568] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Dec  8 07:17:47 raspberrypi kernel: [   39.415568] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Dec  8 07:17:48 raspberrypi kernel: [   40.369046] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:51 raspberrypi kernel: [   43.529073] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:52 raspberrypi org.gtk.Private.AfcVolumeMonitor[578]: Volume monitor alive
Dec  8 07:17:54 raspberrypi kernel: [   46.689049] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:58 raspberrypi kernel: [   49.848996] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:18:01 raspberrypi kernel: [   53.009017] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:18:04 raspberrypi kernel: [   56.168993] cfg80211: Exceeded CRDA call max attempts. Not calling CRDA
Dec  8 07:17:34 raspberrypi rsyslogd: [origin software="rsyslogd" swVersion="8.4.2" x-pid="516" x-info="http://www.rsyslog.com"] start
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Booting Linux on physical CPU 0x0
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Initializing cgroup subsys cpuset
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Initializing cgroup subsys cpu
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Initializing cgroup subsys cpuacct
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Linux version 4.1.7+ (dc4@dc4-XPS13-9333) (gcc version 4.8.3 20140303 (prerelease) (crosstool-NG linaro-1.13.1+bzr2650 - Linaro GCC 2014.03) ) #817 PREEMPT Sat Sep 19 15:25:36 BST 2015
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] CPU: ARMv6-compatible processor [410fb767] revision 7 (ARMv7), cr=00c5387d
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] CPU: PIPT / VIPT nonaliasing data cache, VIPT nonaliasing instruction cache
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Machine model: Raspberry Pi Model A Plus Rev 1.1
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] cma: Reserved 8 MiB at 0x0b800000
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Memory policy: Data cache writeback
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Built 1 zonelists in Zone order, mobility grouping on.  Total pages: 48720
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Kernel command line: dma.dmachans=0x7f35 bcm2708_fb.fbwidth=1824 bcm2708_fb.fbheight=984 bcm2708.boardrev=0x12 bcm2708.serial=0xf992ca04 smsc95xx.macaddr=B8:27:EB:92:CA:04 bcm2708_fb.fbswap=1 bcm2708.disk_led_gpio=47 bcm2708.disk_led_active_low=0 sdhci-bcm2708.emmc_clock_freq=250000000 vc_mem.mem_base=0xec00000 vc_mem.mem_size=0x10000000  dwc_otg.lpm_enable=0 console=ttyAMA0,115200 console=tty1 root=/dev/mmcblk0p2 rootfstype=ext4 elevator=deadline fsck.repair=yes rootwait
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] PID hash table entries: 1024 (order: 0, 4096 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Dentry cache hash table entries: 32768 (order: 5, 131072 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Inode-cache hash table entries: 16384 (order: 4, 65536 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Memory: 176864K/196608K available (6132K kernel code, 490K rwdata, 1780K rodata, 348K init, 720K bss, 11552K reserved, 8192K cma-reserved)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Virtual kernel memory layout:
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]     vector  : 0xffff0000 - 0xffff1000   (   4 kB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]     fixmap  : 0xffc00000 - 0xfff00000   (3072 kB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]     vmalloc : 0xcc800000 - 0xff000000   ( 808 MB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]     lowmem  : 0xc0000000 - 0xcc000000   ( 192 MB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]     modules : 0xbf000000 - 0xc0000000   (  16 MB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]       .text : 0xc0008000 - 0xc07c23ec   (7913 kB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]       .init : 0xc07c3000 - 0xc081a000   ( 348 kB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]       .data : 0xc081a000 - 0xc0894824   ( 491 kB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]        .bss : 0xc0894824 - 0xc09489b0   ( 721 kB)
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] Preemptible hierarchical RCU implementation.
Dec  8 07:17:34 raspberrypi kernel: [    0.000000]      Additional per-CPU info printed with stalls.
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] NR_IRQS:522
Dec  8 07:17:34 raspberrypi kernel: [    0.000000] clocksource stc: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 1911260446275 ns
Dec  8 07:17:34 raspberrypi kernel: [    0.000015] sched_clock: 32 bits at 1000kHz, resolution 1000ns, wraps every 2147483647500ns
Dec  8 07:17:34 raspberrypi kernel: [    0.000056] Switching to timer-based delay loop, resolution 1000ns
Dec  8 07:17:34 raspberrypi kernel: [    0.000339] Console: colour dummy device 80x30
Dec  8 07:17:34 raspberrypi kernel: [    0.001761] console [tty1] enabled
Dec  8 07:17:34 raspberrypi kernel: [    0.001825] Calibrating delay loop (skipped), value calculated using timer frequency.. 2.00 BogoMIPS (lpj=10000)
Dec  8 07:17:34 raspberrypi kernel: [    0.001925] pid_max: default: 32768 minimum: 301
Dec  8 07:17:34 raspberrypi kernel: [    0.002285] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.002367] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.003454] Initializing cgroup subsys blkio
Dec  8 07:17:34 raspberrypi kernel: [    0.003552] Initializing cgroup subsys memory
Dec  8 07:17:34 raspberrypi kernel: [    0.003627] Initializing cgroup subsys devices
Dec  8 07:17:34 raspberrypi kernel: [    0.003695] Initializing cgroup subsys freezer
Dec  8 07:17:34 raspberrypi kernel: [    0.003759] Initializing cgroup subsys net_cls
Dec  8 07:17:34 raspberrypi kernel: [    0.003882] CPU: Testing write buffer coherency: ok
Dec  8 07:17:34 raspberrypi kernel: [    0.004009] ftrace: allocating 19773 entries in 58 pages
Dec  8 07:17:34 raspberrypi kernel: [    0.108907] Setting up static identity map for 0x81c0 - 0x81f8
Dec  8 07:17:34 raspberrypi kernel: [    0.111686] devtmpfs: initialized
Dec  8 07:17:34 raspberrypi kernel: [    0.122718] VFP support v0.3: implementor 41 architecture 1 part 20 variant b rev 5
Dec  8 07:17:34 raspberrypi kernel: [    0.123188] clocksource jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
Dec  8 07:17:34 raspberrypi kernel: [    0.125205] pinctrl core: initialized pinctrl subsystem
Dec  8 07:17:34 raspberrypi kernel: [    0.126155] NET: Registered protocol family 16
Dec  8 07:17:34 raspberrypi kernel: [    0.131745] DMA: preallocated 4096 KiB pool for atomic coherent allocations
Dec  8 07:17:34 raspberrypi kernel: [    0.133338] bcm2708.uart_clock = 3000000
Dec  8 07:17:34 raspberrypi kernel: [    0.138906] hw-breakpoint: found 6 breakpoint and 1 watchpoint registers.
Dec  8 07:17:34 raspberrypi kernel: [    0.139000] hw-breakpoint: maximum watchpoint size is 4 bytes.
Dec  8 07:17:34 raspberrypi kernel: [    0.139188] Serial: AMBA PL011 UART driver
Dec  8 07:17:34 raspberrypi kernel: [    0.139500] 20201000.uart: ttyAMA0 at MMIO 0x20201000 (irq = 83, base_baud = 0) is a PL011 rev2
Dec  8 07:17:34 raspberrypi kernel: [    0.528226] console [ttyAMA0] enabled
Dec  8 07:17:34 raspberrypi kernel: [    0.532633] bcm2835-mbox 2000b880.mailbox: mailbox enabled
Dec  8 07:17:34 raspberrypi kernel: [    0.600775] bcm2708-dmaengine 20007000.dma: DMA legacy API manager at f2007000, dmachans=0xf35
Dec  8 07:17:34 raspberrypi kernel: [    0.609663] bcm2708-dmaengine 20007000.dma: Initialized 7 DMA channels (+ 1 legacy)
Dec  8 07:17:34 raspberrypi kernel: [    0.618175] bcm2708-dmaengine 20007000.dma: Load BCM2835 DMA engine driver
Dec  8 07:17:34 raspberrypi kernel: [    0.625175] bcm2708-dmaengine 20007000.dma: dma_debug:0
Dec  8 07:17:34 raspberrypi kernel: [    0.631360] SCSI subsystem initialized
Dec  8 07:17:34 raspberrypi kernel: [    0.635581] usbcore: registered new interface driver usbfs
Dec  8 07:17:34 raspberrypi kernel: [    0.641240] usbcore: registered new interface driver hub
Dec  8 07:17:34 raspberrypi kernel: [    0.646837] usbcore: registered new device driver usb
Dec  8 07:17:34 raspberrypi kernel: [    0.652912] raspberrypi-firmware soc:firmware: Attached to firmware from 2015-09-23 12:12
Dec  8 07:17:34 raspberrypi kernel: [    0.688809] Switched to clocksource stc
Dec  8 07:17:34 raspberrypi kernel: [    0.740123] FS-Cache: Loaded
Dec  8 07:17:34 raspberrypi kernel: [    0.743447] CacheFiles: Loaded
Dec  8 07:17:34 raspberrypi kernel: [    0.763281] NET: Registered protocol family 2
Dec  8 07:17:34 raspberrypi kernel: [    0.769299] TCP established hash table entries: 2048 (order: 1, 8192 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.776382] TCP bind hash table entries: 2048 (order: 1, 8192 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.783062] TCP: Hash tables configured (established 2048 bind 2048)
Dec  8 07:17:34 raspberrypi kernel: [    0.789634] UDP hash table entries: 256 (order: 0, 4096 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.795539] UDP-Lite hash table entries: 256 (order: 0, 4096 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.802303] NET: Registered protocol family 1
Dec  8 07:17:34 raspberrypi kernel: [    0.807336] RPC: Registered named UNIX socket transport module.
Dec  8 07:17:34 raspberrypi kernel: [    0.813465] RPC: Registered udp transport module.
Dec  8 07:17:34 raspberrypi kernel: [    0.818215] RPC: Registered tcp transport module.
Dec  8 07:17:34 raspberrypi kernel: [    0.822999] RPC: Registered tcp NFSv4.1 backchannel transport module.
Dec  8 07:17:34 raspberrypi kernel: [    0.830832] hw perfevents: enabled with armv6_1176 PMU driver, 3 counters available
Dec  8 07:17:34 raspberrypi kernel: [    0.840143] futex hash table entries: 256 (order: -1, 3072 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.862687] VFS: Disk quotas dquot_6.6.0
Dec  8 07:17:34 raspberrypi kernel: [    0.867085] VFS: Dquot-cache hash table entries: 1024 (order 0, 4096 bytes)
Dec  8 07:17:34 raspberrypi kernel: [    0.876762] FS-Cache: Netfs 'nfs' registered for caching
Dec  8 07:17:34 raspberrypi kernel: [    0.883876] NFS: Registering the id_resolver key type
Dec  8 07:17:34 raspberrypi kernel: [    0.889218] Key type id_resolver registered
Dec  8 07:17:34 raspberrypi kernel: [    0.893452] Key type id_legacy registered
Dec  8 07:17:34 raspberrypi kernel: [    0.901493] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252)
Dec  8 07:17:34 raspberrypi kernel: [    0.909596] io scheduler noop registered
Dec  8 07:17:34 raspberrypi kernel: [    0.913607] io scheduler deadline registered (default)
Dec  8 07:17:34 raspberrypi kernel: [    0.919361] io scheduler cfq registered
Dec  8 07:17:34 raspberrypi kernel: [    0.925702] BCM2708FB: allocated DMA memory 4bc00000
Dec  8 07:17:34 raspberrypi kernel: [    0.931063] BCM2708FB: allocated DMA channel 0 @ f2007000
Dec  8 07:17:34 raspberrypi kernel: [    0.960545] Console: switching to colour frame buffer device 228x61
Dec  8 07:17:34 raspberrypi kernel: [    0.985100] Serial: 8250/16550 driver, 0 ports, IRQ sharing disabled
Dec  8 07:17:34 raspberrypi kernel: [    0.993440] vc-cma: Videocore CMA driver
Dec  8 07:17:34 raspberrypi kernel: [    0.997503] vc-cma: vc_cma_base      = 0x00000000
Dec  8 07:17:34 raspberrypi kernel: [    1.002478] vc-cma: vc_cma_size      = 0x00000000 (0 MiB)
Dec  8 07:17:34 raspberrypi kernel: [    1.008005] vc-cma: vc_cma_initial   = 0x00000000 (0 MiB)
Dec  8 07:17:34 raspberrypi kernel: [    1.014042] vc-mem: phys_addr:0x00000000 mem_base=0x0ec00000 mem_size:0x10000000(256 MiB)
Dec  8 07:17:34 raspberrypi kernel: [    1.043593] brd: module loaded
Dec  8 07:17:34 raspberrypi kernel: [    1.056710] loop: module loaded
Dec  8 07:17:34 raspberrypi kernel: [    1.061405] vchiq: vchiq_init_state: slot_zero = 0xcbc80000, is_master = 0
Dec  8 07:17:34 raspberrypi kernel: [    1.070674] Loading iSCSI transport class v2.0-870.
Dec  8 07:17:34 raspberrypi kernel: [    1.077313] usbcore: registered new interface driver smsc95xx
Dec  8 07:17:34 raspberrypi kernel: [    1.083624] dwc_otg: version 3.00a 10-AUG-2012 (platform bus)
Dec  8 07:17:34 raspberrypi kernel: [    1.290122] Core Release: 2.80a
Dec  8 07:17:34 raspberrypi kernel: [    1.293393] Setting default values for core params
Dec  8 07:17:34 raspberrypi kernel: [    1.298331] Finished setting default values for core params
Dec  8 07:17:34 raspberrypi kernel: [    1.504363] Using Buffer DMA mode
Dec  8 07:17:34 raspberrypi kernel: [    1.507801] Periodic Transfer Interrupt Enhancement - disabled
Dec  8 07:17:34 raspberrypi kernel: [    1.513818] Multiprocessor Interrupt Enhancement - disabled
Dec  8 07:17:34 raspberrypi kernel: [    1.519570] OTG VER PARAM: 0, OTG VER FLAG: 0
Dec  8 07:17:34 raspberrypi kernel: [    1.524037] Dedicated Tx FIFOs mode
Dec  8 07:17:34 raspberrypi kernel: [    1.528087] WARN::dwc_otg_hcd_init:1047: FIQ DMA bounce buffers: virt = 0xcbc14000 dma = 0x4bc14000 len=9024
Dec  8 07:17:34 raspberrypi kernel: [    1.538235] FIQ FSM acceleration enabled for :
Dec  8 07:17:34 raspberrypi kernel: [    1.538235] Non-periodic Split Transactions
Dec  8 07:17:34 raspberrypi kernel: [    1.538235] Periodic Split Transactions
Dec  8 07:17:34 raspberrypi kernel: [    1.538235] High-Speed Isochronous Endpoints
Dec  8 07:17:34 raspberrypi kernel: [    1.555546] WARN::hcd_init_fiq:412: FIQ on core 0 at 0xc0423ab8
Dec  8 07:17:34 raspberrypi kernel: [    1.566961] WARN::hcd_init_fiq:413: FIQ ASM at 0xc0423d90 length 36
Dec  8 07:17:34 raspberrypi kernel: [    1.578500] WARN::hcd_init_fiq:438: MPHI regs_base at 0xcc896000
Dec  8 07:17:34 raspberrypi kernel: [    1.590054] dwc_otg 20980000.usb: DWC OTG Controller
Dec  8 07:17:34 raspberrypi kernel: [    1.600595] dwc_otg 20980000.usb: new USB bus registered, assigned bus number 1
Dec  8 07:17:34 raspberrypi kernel: [    1.613362] dwc_otg 20980000.usb: irq 32, io mem 0x00000000
Dec  8 07:17:34 raspberrypi kernel: [    1.624419] Init: Port Power? op_state=1
Dec  8 07:17:34 raspberrypi kernel: [    1.633728] Init: Power Port (0)
Dec  8 07:17:34 raspberrypi kernel: [    1.642592] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
Dec  8 07:17:34 raspberrypi kernel: [    1.654847] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
Dec  8 07:17:34 raspberrypi kernel: [    1.667487] usb usb1: Product: DWC OTG Controller
Dec  8 07:17:34 raspberrypi kernel: [    1.677476] usb usb1: Manufacturer: Linux 4.1.7+ dwc_otg_hcd
Dec  8 07:17:34 raspberrypi kernel: [    1.688597] usb usb1: SerialNumber: 20980000.usb
Dec  8 07:17:34 raspberrypi kernel: [    1.699878] hub 1-0:1.0: USB hub found
Dec  8 07:17:34 raspberrypi kernel: [    1.709247] hub 1-0:1.0: 1 port detected
Dec  8 07:17:34 raspberrypi kernel: [    1.720011] usbcore: registered new interface driver usb-storage
Dec  8 07:17:34 raspberrypi kernel: [    1.732079] mousedev: PS/2 mouse device common for all mice
Dec  8 07:17:34 raspberrypi kernel: [    1.744343] bcm2835-cpufreq: min=700000 max=700000
Dec  8 07:17:34 raspberrypi kernel: [    1.755222] sdhci: Secure Digital Host Controller Interface driver
Dec  8 07:17:34 raspberrypi kernel: [    1.766898] sdhci: Copyright(c) Pierre Ossman
Dec  8 07:17:34 raspberrypi kernel: [    1.777191] mmc-bcm2835 20300000.mmc: mmc_debug:0 mmc_debug2:0
Dec  8 07:17:34 raspberrypi kernel: [    1.788478] mmc-bcm2835 20300000.mmc: DMA channels allocated
Dec  8 07:17:34 raspberrypi kernel: [    1.839335] sdhci-pltfm: SDHCI platform and OF driver helper
Dec  8 07:17:34 raspberrypi kernel: [    1.858017] ledtrig-cpu: registered to indicate activity on CPUs
Dec  8 07:17:34 raspberrypi kernel: [    1.871023] hidraw: raw HID events driver (C) Jiri Kosina
Dec  8 07:17:34 raspberrypi kernel: [    1.884434] usbcore: registered new interface driver usbhid
Dec  8 07:17:34 raspberrypi kernel: [    1.896439] usbhid: USB HID core driver
Dec  8 07:17:34 raspberrypi kernel: [    1.909076] Indeed it is in host mode hprt0 = 00021501
Dec  8 07:17:34 raspberrypi kernel: [    1.919738] Initializing XFRM netlink socket
Dec  8 07:17:34 raspberrypi kernel: [    1.938971] NET: Registered protocol family 17
Dec  8 07:17:34 raspberrypi kernel: [    1.952788] Key type dns_resolver registered
Dec  8 07:17:34 raspberrypi kernel: [    1.966224] mmc0: host does not support reading read-only switch, assuming write-enable
Dec  8 07:17:34 raspberrypi kernel: [    1.990854] registered taskstats version 1
Dec  8 07:17:34 raspberrypi kernel: [    2.009374] vc-sm: Videocore shared memory driver
Dec  8 07:17:34 raspberrypi kernel: [    2.020012] mmc0: new high speed SDHC card at address 1234
Dec  8 07:17:34 raspberrypi kernel: [    2.049612] mmcblk0: mmc0:1234 SA08G 7.21 GiB
Dec  8 07:17:34 raspberrypi kernel: [    2.059539] [vc_sm_connected_init]: start
Dec  8 07:17:34 raspberrypi kernel: [    2.076776]  mmcblk0: p1 p2
Dec  8 07:17:34 raspberrypi kernel: [    2.085354] [vc_sm_connected_init]: end - returning 0
Dec  8 07:17:34 raspberrypi kernel: [    2.103879] EXT4-fs (mmcblk0p2): INFO: recovery required on readonly filesystem
Dec  8 07:17:34 raspberrypi kernel: [    2.117078] EXT4-fs (mmcblk0p2): write access will be enabled during recovery
Dec  8 07:17:34 raspberrypi kernel: [    2.209034] usb 1-1: new high-speed USB device number 2 using dwc_otg
Dec  8 07:17:34 raspberrypi kernel: [    2.222348] Indeed it is in host mode hprt0 = 00001101
Dec  8 07:17:34 raspberrypi kernel: [    2.439618] usb 1-1: New USB device found, idVendor=1a40, idProduct=0101
Dec  8 07:17:34 raspberrypi kernel: [    2.452057] usb 1-1: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Dec  8 07:17:34 raspberrypi kernel: [    2.464611] usb 1-1: Product: USB 2.0 Hub [MTT]
Dec  8 07:17:34 raspberrypi kernel: [    2.475812] hub 1-1:1.0: USB hub found
Dec  8 07:17:34 raspberrypi kernel: [    2.485328] hub 1-1:1.0: 4 ports detected
Dec  8 07:17:34 raspberrypi kernel: [    2.768900] usb 1-1.4: new high-speed USB device number 3 using dwc_otg
Dec  8 07:17:34 raspberrypi kernel: [    2.879635] usb 1-1.4: New USB device found, idVendor=1a40, idProduct=0201
Dec  8 07:17:34 raspberrypi kernel: [    2.892106] usb 1-1.4: New USB device strings: Mfr=0, Product=1, SerialNumber=0
Dec  8 07:17:34 raspberrypi kernel: [    2.904826] usb 1-1.4: Product: USB 2.0 Hub [MTT]
Dec  8 07:17:34 raspberrypi kernel: [    2.915997] hub 1-1.4:1.0: USB hub found
Dec  8 07:17:34 raspberrypi kernel: [    2.925446] hub 1-1.4:1.0: 7 ports detected
Dec  8 07:17:34 raspberrypi kernel: [    3.228928] usb 1-1.4.1: new full-speed USB device number 4 using dwc_otg
Dec  8 07:17:34 raspberrypi kernel: [    3.367007] usb 1-1.4.1: New USB device found, idVendor=046d, idProduct=c534
Dec  8 07:17:34 raspberrypi kernel: [    3.379428] usb 1-1.4.1: New USB device strings: Mfr=1, Product=2, SerialNumber=0
Dec  8 07:17:34 raspberrypi kernel: [    3.392315] usb 1-1.4.1: Product: USB Receiver
Dec  8 07:17:34 raspberrypi kernel: [    3.402131] usb 1-1.4.1: Manufacturer: Logitech
Dec  8 07:17:34 raspberrypi kernel: [    3.421449] input: Logitech USB Receiver as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.4/1-1.4.1/1-1.4.1:1.0/0003:046D:C534.0001/input/input0
Dec  8 07:17:34 raspberrypi kernel: [    3.499357] hid-generic 0003:046D:C534.0001: input,hidraw0: USB HID v1.11 Keyboard [Logitech USB Receiver] on usb-20980000.usb-1.4.1/input0
Dec  8 07:17:34 raspberrypi kernel: [    3.536940] input: Logitech USB Receiver as /devices/platform/soc/20980000.usb/usb1/1-1/1-1.4/1-1.4.1/1-1.4.1:1.1/0003:046D:C534.0002/input/input1
Dec  8 07:17:34 raspberrypi kernel: [    3.609981] hid-generic 0003:046D:C534.0002: input,hiddev0,hidraw1: USB HID v1.11 Mouse [Logitech USB Receiver] on usb-20980000.usb-1.4.1/input1
Dec  8 07:17:34 raspberrypi kernel: [    3.708911] usb 1-1.4.7: new high-speed USB device number 5 using dwc_otg
Dec  8 07:17:34 raspberrypi kernel: [    3.820702] usb 1-1.4.7: New USB device found, idVendor=0bda, idProduct=8152
Dec  8 07:17:34 raspberrypi kernel: [    3.833906] usb 1-1.4.7: New USB device strings: Mfr=1, Product=2, SerialNumber=3
Dec  8 07:17:34 raspberrypi kernel: [    3.847333] usb 1-1.4.7: Product: USB 10/100 LAN
Dec  8 07:17:34 raspberrypi kernel: [    3.857879] usb 1-1.4.7: Manufacturer: Realtek
Dec  8 07:17:34 raspberrypi kernel: [    3.868349] usb 1-1.4.7: SerialNumber: 00E04C36123C
Dec  8 07:17:34 raspberrypi kernel: [    7.121135] EXT4-fs (mmcblk0p2): orphan cleanup on readonly fs
Dec  8 07:17:34 raspberrypi kernel: [    7.134300] EXT4-fs (mmcblk0p2): 4 orphan inodes deleted
Dec  8 07:17:34 raspberrypi kernel: [    7.145727] EXT4-fs (mmcblk0p2): recovery complete
Dec  8 07:17:34 raspberrypi kernel: [    8.983801] EXT4-fs (mmcblk0p2): mounted filesystem with ordered data mode. Opts: (null)
Dec  8 07:17:34 raspberrypi kernel: [    8.998051] VFS: Mounted root (ext4 filesystem) readonly on device 179:2.
Dec  8 07:17:34 raspberrypi kernel: [    9.012224] devtmpfs: mounted
Dec  8 07:17:34 raspberrypi kernel: [    9.022589] Freeing unused kernel memory: 348K (c07c3000 - c081a000)
Dec  8 07:17:34 raspberrypi kernel: [    9.413639] random: systemd urandom read with 116 bits of entropy available
Dec  8 07:17:34 raspberrypi kernel: [    9.654609] NET: Registered protocol family 10
Dec  8 07:17:34 raspberrypi kernel: [    9.827805] uart-pl011 20201000.uart: no DMA platform data
Dec  8 07:17:34 raspberrypi kernel: [   10.025293] random: nonblocking pool is initialized
Dec  8 07:17:34 raspberrypi kernel: [   11.920463] fuse init (API version 7.23)
Dec  8 07:17:34 raspberrypi kernel: [   12.125898] i2c /dev entries driver
Dec  8 07:17:34 raspberrypi kernel: [   15.769636] gpiomem-bcm2835 20200000.gpiomem: Initialised: Registers at 0x20200000
Dec  8 07:17:34 raspberrypi kernel: [   15.821750] EXT4-fs (mmcblk0p2): re-mounted. Opts: (null)
Dec  8 07:17:34 raspberrypi kernel: [   17.749017] usb 1-1.4.7: reset high-speed USB device number 5 using dwc_otg
Dec  8 07:17:34 raspberrypi kernel: [   17.925766] r8152 1-1.4.7:1.0 eth0: v1.08.0 (2015/01/13)
Dec  8 07:17:34 raspberrypi kernel: [   17.929745] usbcore: registered new interface driver r8152
Dec  8 07:17:34 raspberrypi kernel: [   17.934285] usbcore: registered new interface driver cdc_ether
Dec  8 07:17:34 raspberrypi kernel: [   20.989514] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
Dec  8 07:17:34 raspberrypi kernel: [   22.559691] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:34 raspberrypi kernel: [   22.705807] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
Dec  8 07:17:34 raspberrypi kernel: [   25.535353] Adding 102396k swap on /var/swap.  Priority:-1 extents:5 across:573436k SSFS
Dec  8 07:17:34 raspberrypi kernel: [   25.719953] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:37 raspberrypi kernel: [   28.879076] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:40 raspberrypi kernel: [   32.039082] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:43 raspberrypi kernel: [   35.199136] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 07:17:46 raspberrypi kernel: [   38.359020] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 12:10:57 raspberrypi kernel: [   41.519014] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 12:11:00 raspberrypi org.gtk.Private.AfcVolumeMonitor[667]: Volume monitor alive
Dec  8 12:11:00 raspberrypi kernel: [   44.679046] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 12:11:04 raspberrypi kernel: [   47.838937] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 12:11:07 raspberrypi kernel: [   50.998975] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 12:11:10 raspberrypi kernel: [   54.159074] cfg80211: Calling CRDA to update world regulatory domain
Dec  8 12:11:13 raspberrypi kernel: [   57.318918] cfg80211: Exceeded CRDA call max attempts. Not calling CRDA
Dec  8 12:11:17 raspberrypi kernel: [   61.111305] usb 1-1.4.1: USB disconnect, device number 4

@popcornmix
Copy link
Collaborator

Does the pi hang and need rebooting before you see the messages? How are you viewing them?

@huangjiansword
Copy link
Author

Are you starting from initial console (i.e. not desktop).
From desktop, but it hang also starting from console

Are you interacting with keyboard/display?
Yes, with hdmi display and keyboard

After the crash does the display appears exactly as it did before or does it blank?
Appears exactly as it did

Does the pi hang and need rebooting before you see the messages?
Yes, the pi hang and need rebooting, then I got the messages from /var/log/messages

How are you viewing them?
tail /var/log/message -n 300

@popcornmix
Copy link
Collaborator

Can you add dwc_otg.fiq_enable=0 dwc_otg.fiq_fsm_enable=0 to end of cmdline.txt (on same line) and report if any change in behaviour?

@huangjiansword
Copy link
Author

I just tried it, but there is no use with dwc_otg.fiq_enable=0 dwc_otg.fiq_fsm_enable=0.

Also, I tried to add max_usb_current=1 to /boot/config.txt, issue remains.

@popcornmix
Copy link
Collaborator

Just to confirm, you should see:

[    1.882870] dwc_otg: FIQ disabled
[    1.882888] dwc_otg: FIQ split-transaction FSM disabled

in log.

@huangjiansword
Copy link
Author

Yes, confirmed


pi@raspberrypi ~ $ dmesg | grep FIQ
[    1.635657] dwc_otg: FIQ disabled
[    1.635698] dwc_otg: FIQ split-transaction FSM disabled

@popcornmix
Copy link
Collaborator

@P33M any ideas?

@P33M
Copy link
Contributor

P33M commented Dec 8, 2015

Where can I buy one of these devices?

@huangjiansword
Copy link
Author

could you give me your address, so I can mail you some r8152s, my mailbox is huangjiansword@hotmail.com

and also you can buy it from here:
http://www.amazon.com/USB-Ethernet-Network-Adapter-Card/dp/B018TK0LVA/ref=sr_1_2?ie=UTF8&qid=1449633667&sr=8-2&keywords=8152+usb+ethernet

the chip is RTL8152

@huangjiansword
Copy link
Author

Another finding, I tried the same device with RPI2 model B V 1.1, it works no hang no crash!

@P33M
Copy link
Contributor

P33M commented Jan 5, 2016

I can replicate the issue. 1 in 5 hot-unplugs on a Pi 1 B+ cause a crash. So far 20+ hot-unplugs on a Pi 2B = no crash.

@huangjiansword
Copy link
Author

Yes, the same phenomena as me.

@huangjiansword
Copy link
Author

@P33M @popcornmix, any suggestion about this issue? I think maybe 8152 driver should be fixed, but the guys from realtek said it's not 8152 issue but host controller's issue. but I can not reproduce the issue if I unload the 8152 driver.

@P33M
Copy link
Contributor

P33M commented Jan 11, 2016

What's curious is the fact that it crashes on a Pi 1 (single-processor) but apparently doesn't on Pi 2 (multiprocessor). The Pi just hard-freezes without printing a stacktrace which is most unusual.

@huangjiansword
Copy link
Author

What's the difference between Pi1 and Pi2 concerning USB controller?On what condition will the core print no any stacktrace or dmesg message?

@huangjiansword
Copy link
Author

On 3.12.20+, unplug 8152 will not freeze system, but on 3.18.7+, the issue appears, I think maybe some hub or host controller's modification cause this issue.

@huangjiansword
Copy link
Author

@popcornmix @P33M I also tried with Jessie and r8152, the same issue remains.

@mlord
Copy link

mlord commented Oct 26, 2016

The r8152 driver has been broken since (approx) 3.16.xx
when support was added for hardware rx checksum on newer chip versions.
Symptoms include random segfaults and silent data corruption over NFS.

This does not work on the VER_02 dongle I have here
when used with a slow embedded system CPU.

So, disable hardware rx checksum for VER_02, and fix
an obvious coding error for IPV6 checksums in the same function.

Patch submitted upstream for this today: https://lkml.org/lkml/2016/10/26/1167

@popcornmix
Copy link
Collaborator

@mlord thanks for info. Let us know when the patch is merged upstream and we can cherry pick it.

@P33M
Copy link
Contributor

P33M commented May 4, 2017

Fixed upstream in -stable: https://lkml.org/lkml/2017/1/11/759

Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment
Labels
None yet
Projects
None yet
Development

No branches or pull requests

4 participants