IRATI / stack

RINA implementation for OS/Linux
http://irati.github.io/stack
72 stars 40 forks source link

The stack panics as soon as it is started (NL sock notification related) #68

Closed kewinrausch closed 9 years ago

kewinrausch commented 9 years ago

Issue by salvestrini Monday Sep 23, 2013 at 09:55 GMT Originally opened as https://github.com/dana-i2cat/irati/issues/65


kewinrausch commented 9 years ago

Comment by edugrasa Wednesday Sep 25, 2013 at 08:02 GMT


Could you give me more data about this error? I've not been able to reproduce the error and I've been testing it for a couple of days now.. Maybe you can merge from eduard-stable now and try again? (or merge the pull-request to irati)

kewinrausch commented 9 years ago

Comment by salvestrini Wednesday Sep 25, 2013 at 08:24 GMT


As soon as the kernel starts, an error (in the boot console) is presented and dmesg shows a huge amount of kernel dumps in the klog. Please find attached the logs (obtained as: a) boot the kernel, b) dmesg > /tmp/logs.txt).

Look for the following string: '[ 16.271374] rina-netlink: Netlink socket at port-id 83 closed'. That should be the kernel' initial rants.

The only commit missing is your last one, which involves only the user-space (so it won't solve the issue which appears at kernel boot time). Your branch is outdated however, may you merge from wip-francesco again and request another pull ?

Ciao, Francesco

On Wed, Sep 25, 2013 at 10:02 AM, Eduard Grasa notifications@github.comwrote:

Could you give me more data about this error? I've not been able to reproduce the error and I've been testing it for a couple of days now.. Maybe you can merge from eduard-stable now and try again? (or merge the pull-request to irati)

— Reply to this email directly or view it on GitHubhttps://github.com/dana-i2cat/irati/issues/65#issuecomment-25068283 .

[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.10.0 (francesco@ikira) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu5) ) #407 SMP Mon Sep 23 16:24:29 CEST 2013 [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.10.0 root=UUID=84c09d8d-2d53-4687-bb61-913f38f8cd7f ro quiet [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffeffff] usable [ 0.000000] BIOS-e820: [mem 0x000000003fff0000-0x000000003fffffff] ACPI data [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.5 present. [ 0.000000] DMI: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] No AGP bridge found [ 0.000000] e820: last_pfn = 0x3fff0 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: uncachable [ 0.000000] MTRR variable ranges disabled: [ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106 [ 0.000000] CPU MTRRs all blank - virtualized system. [ 0.000000] Scanning 1 areas for low memory corruption [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] BRK [0x02a1b000, 0x02a1bfff] PGTABLE [ 0.000000] BRK [0x02a1c000, 0x02a1cfff] PGTABLE [ 0.000000] BRK [0x02a1d000, 0x02a1dfff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x3fc00000-0x3fdfffff] [ 0.000000] [mem 0x3fc00000-0x3fdfffff] page 4k [ 0.000000] BRK [0x02a1e000, 0x02a1efff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x3c000000-0x3fbfffff] [ 0.000000] [mem 0x3c000000-0x3fbfffff] page 4k [ 0.000000] BRK [0x02a1f000, 0x02a1ffff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x3bffffff] [ 0.000000] [mem 0x00100000-0x3bffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x3fe00000-0x3ffeffff] [ 0.000000] [mem 0x3fe00000-0x3ffeffff] page 4k [ 0.000000] RAMDISK: [mem 0x2a516000-0x31282fff] [ 0.000000] ACPI: RSDP 00000000000e0000 00024 (v02 VBOX ) [ 0.000000] ACPI: XSDT 000000003fff0030 00034 (v01 VBOX VBOXXSDT 00000001 ASL 00000061) [ 0.000000] ACPI: FACP 000000003fff00f0 000F4 (v04 VBOX VBOXFACP 00000001 ASL 00000061) [ 0.000000] ACPI: DSDT 000000003fff0410 01B96 (v01 VBOX VBOXBIOS 00000002 INTL 20100528) [ 0.000000] ACPI: FACS 000000003fff0200 00040 [ 0.000000] ACPI: SSDT 000000003fff0240 001CC (v01 VBOX VBOXCPUT 00000002 INTL 20100528) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000003ffeffff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x3ffeffff] [ 0.000000] NODE_DATA [mem 0x3ffeb000-0x3ffeffff] [ 0.000000] [ffffea0000000000-ffffea0000ffffff] PMD -> [ffff88003e400000-ffff88003f3fffff] on node 0 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00001000-0x0009efff] [ 0.000000] node 0: [mem 0x00100000-0x3ffeffff] [ 0.000000] On node 0 totalpages: 262030 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 4032 pages used for memmap [ 0.000000] DMA32 zone: 258032 pages, LIFO batch:31 [ 0.000000] ACPI: PM-Timer IO Port: 0x4008 [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] nr_irqs_gsi: 16 [ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 [ 0.000000] e820: [mem 0x40000000-0xfffbffff] available for PCI devices [ 0.000000] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 476 pages/cpu @ffff88003fa00000 s1920640 r8192 d20864 u2097152 [ 0.000000] pcpu-alloc: s1920640 r8192 d20864 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257913 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.10.0 root=UUID=84c09d8d-2d53-4687-bb61-913f38f8cd7f ro quiet [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Calgary: detecting Calgary via BIOS EBDA area [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing! [ 0.000000] Memory: 888132k/1048512k available (7002k kernel code, 392k absent, 159988k reserved, 6350k data, 3028k init) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16640 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 6367 kB [ 0.000000] per task-struct memory footprint: 2688 bytes [ 0.000000] tsc: Fast TSC calibration failed [ 0.000000] tsc: PIT calibration matches PMTIMER. 2 loops [ 0.000000] tsc: Detected 2847.834 MHz processor [ 0.012002] Calibrating delay loop (skipped), value calculated using timer frequency.. 5695.66 BogoMIPS (lpj=11391336) [ 0.012005] pid_max: default: 32768 minimum: 301 [ 0.012654] Security Framework initialized [ 0.012734] AppArmor: AppArmor initialized [ 0.018215] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.019575] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.019782] Mount-cache hash table entries: 256 [ 0.022777] Initializing cgroup subsys devices [ 0.022840] Initializing cgroup subsys freezer [ 0.022862] Initializing cgroup subsys blkio [ 0.022864] Initializing cgroup subsys perf_event [ 0.023539] mce: CPU supports 0 MCE banks [ 0.024047] Last level iTLB entries: 4KB 512, 2MB 0, 4MB 0 [ 0.024047] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32 [ 0.024047] tlb_flushall_shift: 1 [ 0.048601] debug: unmapping init [mem 0xffffffff82001000-0xffffffff82006fff] [ 0.048663] ACPI: Core revision 20130328 [ 0.140552] ACPI: All ACPI Tables successfully acquired [ 0.140565] ACPI: setting ELCR to 0200 (from 0e20) [ 0.140595] ftrace: allocating 25664 entries in 101 pages [ 0.153082] smpboot: weird, boot CPU (#3) not listed by the BIOS [ 0.153090] smpboot: SMP motherboard not detected [ 0.156000] ------------[ cut here ]------------ [ 0.156000] WARNING: at kernel/time/clockevents.c:46 clockevent_delta2ns+0x6b/0x80() [ 0.156000] Modules linked in: [ 0.156000] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 3.10.0 #407 [ 0.156000] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 0.156000] ffffffff81a27beb ffff88003dcb1de8 ffffffff816c0db1 ffff88003dcb1e28 [ 0.156000] ffffffff81043f10 0000000000000000 ffffffff81c1fb40 0000000000000000 [ 0.156000] 00000000110bf76c 0000000000000000 000000000005763f ffff88003dcb1e38 [ 0.156000] Call Trace: [ 0.156000] [] dump_stack+0x19/0x1b [ 0.156000] [] warn_slowpath_common+0x70/0xa0 [ 0.156000] [] warn_slowpath_null+0x1a/0x20 [ 0.156000] [] clockevent_delta2ns+0x6b/0x80 [ 0.156000] [] ? setup_boot_APIC_clock+0x142/0x4f1 [ 0.156000] [] setup_boot_APIC_clock+0x2c2/0x4f1 [ 0.156000] [] APIC_init_uniprocessor+0xf9/0xfd [ 0.156000] [] native_smp_prepare_cpus+0x210/0x453 [ 0.156000] [] kernel_init_freeable+0x8d/0x1cb [ 0.156000] [] ? rest_init+0xe0/0xe0 [ 0.156000] [] kernel_init+0xe/0xf0 [ 0.156000] [] ret_from_fork+0x7c/0xb0 [ 0.156000] [] ? rest_init+0xe0/0xe0 [ 0.156000] ---[ end trace 71f1979ecf379b7b ]--- [ 0.156000] APIC frequency too slow, disabling apic timer [ 0.156000] smpboot: SMP disabled [ 0.156000] Performance Events: unsupported p6 CPU model 58 no PMU driver, software events only. [ 0.156000] Brought up 1 CPUs [ 0.156000] smpboot: Total of 1 processors activated (5695.66 BogoMIPS) [ 0.156000] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.156106] devtmpfs: initialized [ 0.166172] EVM: security.selinux [ 0.166175] EVM: security.SMACK64 [ 0.166176] EVM: security.capability [ 0.193001] regulator-dummy: no parameters [ 0.193456] RTC time: 8:19:26, date: 09/25/13 [ 0.194205] NET: Registered protocol family 16 [ 0.197433] ACPI: bus type PCI registered [ 0.198605] PCI: Using configuration type 1 for base access [ 0.238616] bio: create slab at 0 [ 0.243072] ACPI: Added _OSI(Module Device) [ 0.243088] ACPI: Added _OSI(Processor Device) [ 0.243103] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.243127] ACPI: Added _OSI(Processor Aggregator Device) [ 0.244957] ACPI: EC: Look up EC in DSDT [ 0.258011] ACPI: Executed 1 blocks of module-level executable AML code [ 0.514869] ACPI: Interpreter enabled [ 0.515066] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S1 [ 0.515288] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S2 [ 0.515510] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S3 [ 0.515761] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S4 [ 0.515875] ACPI: (supports S0 S5) [ 0.515877] ACPI: Using PIC for interrupt routing [ 0.534747] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug [ 0.537917] ACPI: No dock devices found. [ 0.733185] ACPI: PCI Root Bridge [PCI0](domain 0000 [bus 00-ff]) [ 0.736000] acpi PNP0A03:00: host bridge window io 0x0000-0x0cf7 [ 0.736000] acpi PNP0A03:00: host bridge window io 0x0d00-0xffff [ 0.736000] acpi PNP0A03:00: host bridge window mem 0x000a0000-0x000bffff [ 0.736000] acpi PNP0A03:00: host bridge window mem 0x40000000-0xffdfffff [ 0.736000] PCI: root bus 00: using default resources [ 0.736000] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.736879] PCI host bridge to bus 0000:00 [ 0.736898] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.736911] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 0.736922] pci_bus 0000:00: root bus resource [mem 0x00000000-0xfffffffff] [ 0.737009] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.738861] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.741166] pci 0000:00:01.1: [8086:7111] type 00 class 0x01018a [ 0.741575] pci 0000:00:01.1: reg 20: [io 0xd000-0xd00f] [ 0.746642] pci 0000:00:02.0: [80ee:beef] type 00 class 0x030000 [ 0.747591] pci 0000:00:02.0: reg 10: [mem 0xe0000000-0xe0ffffff pref] [ 0.755240] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.756129] pci 0000:00:03.0: reg 10: [mem 0xf0000000-0xf001ffff] [ 0.757163] pci 0000:00:03.0: reg 18: [io 0xd010-0xd017] [ 0.762323] pci 0000:00:04.0: [80ee:cafe] type 00 class 0x088000 [ 0.762933] pci 0000:00:04.0: reg 10: [io 0xd020-0xd03f] [ 0.763468] pci 0000:00:04.0: reg 14: [mem 0xf0400000-0xf07fffff] [ 0.764166] pci 0000:00:04.0: reg 18: [mem 0xf0800000-0xf0803fff pref] [ 0.769493] pci 0000:00:05.0: [8086:2415] type 00 class 0x040100 [ 0.769599] pci 0000:00:05.0: reg 10: [io 0xd100-0xd1ff] [ 0.769673] pci 0000:00:05.0: reg 14: [io 0xd200-0xd23f] [ 0.772865] pci 0000:00:06.0: [106b:003f] type 00 class 0x0c0310 [ 0.773494] pci 0000:00:06.0: reg 10: [mem 0xf0804000-0xf0804fff] [ 0.779552] pci 0000:00:07.0: [8086:7113] type 00 class 0x068000 [ 0.782481] pci 0000:00:0d.0: [8086:2829] type 00 class 0x010601 [ 0.784143] pci 0000:00:0d.0: reg 10: [io 0xd240-0xd247] [ 0.785217] pci 0000:00:0d.0: reg 18: [io 0xd250-0xd257] [ 0.786282] pci 0000:00:0d.0: reg 20: [io 0xd260-0xd26f] [ 0.786809] pci 0000:00:0d.0: reg 24: [mem 0xf0806000-0xf0807fff] [ 0.790946] acpi PNP0A03:00: ACPI _OSC support notification failed, disabling PCIe ASPM [ 0.790949] acpi PNP0A03:00: Unable to request _OSC control (_OSC support mask: 0x08) [ 0.860226] ACPI: PCI Interrupt Link [LNKA](IRQs 5 9 10 11) [ 0.889601] ACPI: PCI Interrupt Link [LNKB](IRQs 5 9 10 11) [ 0.897000] ACPI: PCI Interrupt Link [LNKC](IRQs 5 9 10 11) [ 0.902668] ACPI: PCI Interrupt Link [LNKD](IRQs 5 9 10 11) [ 0.905224] ACPI: Enabled 1 GPEs in block 00 to 07 [ 0.905246] acpi root: SB.PCI0 notify handler is installed [ 0.905302] Found 1 acpi root devices [ 0.906673] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.906680] vgaarb: loaded [ 0.906681] vgaarb: bridge control possible 0000:00:02.0 [ 0.913898] SCSI subsystem initialized [ 0.913910] ACPI: bus type ATA registered [ 0.914558] libata version 3.00 loaded. [ 0.914969] ACPI: bus type USB registered [ 0.915410] usbcore: registered new interface driver usbfs [ 0.915640] usbcore: registered new interface driver hub [ 0.915861] usbcore: registered new device driver usb [ 0.917554] PCI: Using ACPI for IRQ routing [ 0.917557] PCI: pci_cache_line_size set to 64 bytes [ 0.917759] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.917793] e820: reserve RAM buffer [mem 0x3fff0000-0x3fffffff] [ 0.920062] NetLabel: Initializing [ 0.920064] NetLabel: domain hash size = 128 [ 0.920065] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.920371] NetLabel: unlabeled traffic allowed by default [ 0.920412] Switching to clocksource refined-jiffies [ 1.098183] AppArmor: AppArmor Filesystem Enabled [ 1.098426] pnp: PnP ACPI init [ 1.098623] ACPI: bus type PNP registered [ 1.099593] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) [ 1.099843] pnp 00:01: [dma 4] [ 1.100399] pnp 00:01: Plug and Play ACPI device, IDs PNP0200 (active) [ 1.101565] pnp 00:02: Plug and Play ACPI device, IDs PNP0f03 (active) [ 1.102328] pnp 00:03: Plug and Play ACPI device, IDs PNP0400 (active) [ 1.133429] pnp: PnP ACPI: found 4 devices [ 1.133432] ACPI: bus type PNP unregistered [ 1.179997] Switching to clocksource acpi_pm [ 1.180016] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] [ 1.180016] pci_bus 0000:00: resource 5 [mem 0x00000000-0xfffffffff] [ 1.180016] NET: Registered protocol family 2 [ 1.180016] TCP established hash table entries: 8192 (order: 5, 131072 bytes) [ 1.180292] TCP bind hash table entries: 8192 (order: 7, 655360 bytes) [ 1.180661] TCP: Hash tables configured (established 8192 bind 8192) [ 1.180782] TCP: reno registered [ 1.180990] UDP hash table entries: 512 (order: 4, 98304 bytes) [ 1.181248] UDP-Lite hash table entries: 512 (order: 4, 98304 bytes) [ 1.181960] NET: Registered protocol family 1 [ 1.182224] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.182284] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.182317] pci 0000:00:02.0: Boot video device [ 1.383218] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11 [ 1.383222] PCI: setting IRQ 11 as level-triggered [ 1.511604] PCI: CLS 0 bytes, default 64 [ 1.515079] Trying to unpack rootfs image as initramfs... [ 7.622896] debug: unmapping init [mem 0xffff88002a516000-0xffff880031282fff] [ 7.626706] platform rtc_cmos: registered platform RTC device (no PNP device found) [ 7.627517] Scanning for low memory corruption every 60 seconds [ 7.644087] audit: initializing netlink socket (disabled) [ 7.646099] type=2000 audit(1380097173.639:1): initialized [ 7.695364] bounce pool size: 64 pages [ 7.695492] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 7.846861] VFS: Disk quotas dquot_6.5.2 [ 7.847495] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 7.919168] fuse init (API version 7.22) [ 7.923158] msgmni has been set to 1734 [ 7.927039] cryptomgr_test (30) used greatest stack depth: 6288 bytes left [ 7.931937] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) [ 7.935364] io scheduler noop registered [ 7.935369] io scheduler deadline registered (default) [ 7.942917] io scheduler cfq registered [ 7.947106] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 7.947416] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 7.952095] ACPI: AC Adapter AC [ 7.956002] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 7.956058] ACPI: Power Button [PWRF] [ 7.958944] input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input1 [ 7.958965] ACPI: Sleep Button [SLPF] [ 8.463101] GHES: HEST is not enabled! [ 8.463775] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled [ 8.623782] tsc: Refined TSC clocksource calibration: 2860.087 MHz [ 8.623825] Switching to clocksource tsc [ 9.051514] ACPI: Battery Slot [BAT0](battery present) [ 9.111777] Linux agpgart interface v0.103 [ 9.251851] brd: module loaded [ 9.291494] loop: module loaded [ 9.299554] ata_piix 0000:00:01.1: version 2.13 [ 9.299827] ata_piix 0000:00:01.1: setting latency timer to 64 [ 9.315959] scsi0 : ata_piix [ 9.323112] scsi1 : ata_piix [ 9.327087] ata1: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xd000 irq 14 [ 9.327093] ata2: PATA max UDMA/33 cmd 0x170 ctl 0x376 bmdma 0xd008 irq 15 [ 9.343462] libphy: Fixed MDIO Bus: probed [ 9.347316] tun: Universal TUN/TAP device driver, 1.6 [ 9.347318] tun: (C) 1999-2004 Max Krasnyansky maxk@qualcomm.com [ 9.347994] PPP generic driver version 2.4.2 [ 9.351341] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 9.351343] ehci-pci: EHCI PCI platform driver [ 9.351464] ehci-platform: EHCI generic platform driver [ 9.351682] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 9.486733] ata2.00: ATAPI: VBOX CD-ROM, 1.0, max UDMA/133 [ 9.487201] ata2.00: configured for UDMA/33 [ 9.490994] scsi 1:0:0:0: CD-ROM VBOX CD-ROM 1.0 PQ: 0 ANSI: 5 [ 9.499278] sr0: scsi3-mmc drive: 32x/32x xa/form2 tray [ 9.499288] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 9.506042] ohci_hcd 0000:00:06.0: setting latency timer to 64 [ 9.507858] sr 1:0:0:0: Attached scsi CD-ROM sr0 [ 9.512183] ohci_hcd 0000:00:06.0: OHCI Host Controller [ 9.514334] ohci_hcd 0000:00:06.0: new USB bus registered, assigned bus number 1 [ 9.514488] ohci_hcd 0000:00:06.0: irq 11, io mem 0xf0804000 [ 9.515105] sr 1:0:0:0: Attached scsi generic sg0 type 5 [ 9.573484] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001 [ 9.573487] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 9.573489] usb usb1: Product: OHCI Host Controller [ 9.573490] usb usb1: Manufacturer: Linux 3.10.0 ohci_hcd [ 9.573492] usb usb1: SerialNumber: 0000:00:06.0 [ 9.575652] hub 1-0:1.0: USB hub found [ 9.575777] hub 1-0:1.0: 8 ports detected [ 9.588052] uhci_hcd: USB Universal Host Controller Interface driver [ 9.594589] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12 [ 10.142411] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 10.142592] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 10.147067] mousedev: PS/2 mouse device common for all mice [ 10.151630] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2 [ 10.158882] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0 [ 10.158975] rtc_cmos rtc_cmos: alarms up to one day, 114 bytes nvram [ 10.162610] device-mapper: uevent: version 1.0.3 [ 10.163999] device-mapper: ioctl: 4.24.0-ioctl (2013-01-15) initialised: dm-devel@redhat.com [ 10.164025] cpuidle: using governor ladder [ 10.164027] cpuidle: using governor menu [ 10.168048] ashmem: initialized [ 10.172117] TCP: cubic registered [ 10.179608] NET: Registered protocol family 10 [ 10.188000] NET: Registered protocol family 17 [ 10.190327] Key type dns_resolver registered [ 10.190329] rina-core: RINA stack initializing [ 10.190330] rina-debug: Debugging facilities initializing [ 10.190363] rina-debug: Debug-fs support initialized successfully [ 10.190364] rina-debug: Debugging facilities initialized successfully [ 10.190365] rina-core: Creating root kset [ 10.190411] rina-core: Creating sysfs group [ 10.190422] rina-netlink: Initializing Netlink layer [ 10.190491] rina-netlink: Registering Family returned: 0 [ 10.190492] rina-netlink: Family registered with id: 24 [ 10.190500] rina-netlink: NetLink layer initialized successfully [ 10.190501] rina-personality: Initializing personality layer [ 10.190534] rina-personality: Personality layer initialized successfully [ 10.190535] rina-core: RINA stack v0.1.4 initialized [ 10.195135] PM: Hibernation image not present or could not be loaded. [ 10.195283] registered taskstats version 1 [ 10.195514] kmemleak: Kernel memory leak detector initialized [ 10.195738] kmemleak: Automatic memory scanning thread started [ 10.206341] modprobe (47) used greatest stack depth: 4832 bytes left [ 10.215599] Key type trusted registered [ 10.255169] Key type encrypted registered [ 10.278710] Magic number: 13:16:322 [ 10.278718] misc mcelog: hash matches [ 10.278753] tty tty47: hash matches [ 10.278861] rtc_cmos rtc_cmos: setting system clock to 2013-09-25 08:19:36 UTC (1380097176) [ 10.279288] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 10.279289] EDD information not available. [ 10.286526] debug: unmapping init [mem 0xffffffff81d0c000-0xffffffff82000fff] [ 10.286588] Write protecting the kernel read-only data: 12288k [ 10.286744] debug: unmapping init [mem 0xffff8800016d9000-0xffff8800017fffff] [ 10.286797] debug: unmapping init [mem 0xffff880001b02000-0xffff880001bfffff] [ 10.318492] busybox (70) used greatest stack depth: 4544 bytes left [ 10.324042] busybox (71) used greatest stack depth: 4352 bytes left [ 10.426753] udevd[84]: starting version 175 [ 10.446440] usb 1-1: new full-speed USB device number 2 using ohci_hcd [ 10.718186] usb 1-1: New USB device found, idVendor=80ee, idProduct=0021 [ 10.718189] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 [ 10.718191] usb 1-1: Product: USB Tablet [ 10.718192] usb 1-1: Manufacturer: VirtualBox [ 10.831946] udevadm (85) used greatest stack depth: 4064 bytes left [ 11.655051] ata_id (121) used greatest stack depth: 3184 bytes left [ 11.802953] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 11.802957] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 13.123886] hidraw: raw HID events driver (C) Jiri Kosina [ 13.279884] usbcore: registered new interface driver usbhid [ 13.279887] usbhid: USB HID core driver [ 13.751977] input: VirtualBox USB Tablet as /devices/pci0000:00/0000:00:06.0/usb1/1-1/1-1:1.0/input/input3 [ 13.771678] hid-generic 0003:80EE:0021.0001: input,hidraw0: USB HID v1.10 Mouse [VirtualBox USB Tablet] on usb-0000:00:06.0-1/input0 [ 13.823472] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10 [ 13.823476] PCI: setting IRQ 10 as level-triggered [ 13.823549] e1000 0000:00:03.0: setting latency timer to 64 [ 14.783215] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 08:00:27:70:f3:97 [ 14.783240] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 14.783473] ahci 0000:00:0d.0: version 3.0 [ 15.191763] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 5 [ 15.191767] PCI: setting IRQ 5 as level-triggered [ 15.195489] ahci: SSS flag set, parallel bus scan disabled [ 15.195681] ahci 0000:00:0d.0: AHCI 0001.0100 32 slots 1 ports 3 Gbps 0x1 impl SATA mode [ 15.195690] ahci 0000:00:0d.0: flags: 64bit ncq stag only ccc [ 15.195711] ahci 0000:00:0d.0: setting latency timer to 64 [ 15.210840] scsi2 : ahci [ 15.215733] ata3: SATA max UDMA/133 abar m8192@0xf0806000 port 0xf0806100 irq 5 [ 15.538807] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 15.539042] ata3.00: ATA-6: VBOX HARDDISK, 1.0, max UDMA/133 [ 15.539065] ata3.00: 16777216 sectors, multi 128: LBA48 NCQ (depth 31/32) [ 15.539385] ata3.00: configured for UDMA/133 [ 15.549495] scsi 2:0:0:0: Direct-Access ATA VBOX HARDDISK 1.0 PQ: 0 ANSI: 5 [ 15.555703] sd 2:0:0:0: [sda] 16777216 512-byte logical blocks: (8.58 GB/8.00 GiB) [ 15.558963] sd 2:0:0:0: [sda] Write Protect is off [ 15.558966] sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 15.560036] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 15.564081] sd 2:0:0:0: Attached scsi generic sg1 type 0 [ 15.584778] sda: sda1 sda2 < sda5 > [ 15.595444] sd 2:0:0:0: [sda] Attached SCSI disk [ 16.190982] PM: Starting manual resume from disk [ 16.190990] PM: Hibernation image partition 8:5 present [ 16.190991] PM: Looking for hibernation image. [ 16.192000] PM: Image not found (code -22) [ 16.192004] PM: Hibernation image not present or could not be loaded. [ 16.247692] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) [ 16.271374] rina-netlink: Netlink socket at port-id 83 closed [ 16.271380] BUG: sleeping function called from invalid context at mm/slub.c:926 [ 16.271796] in_atomic(): 1, irqs_disabled(): 0, pid: 84, name: udevd [ 16.274104] 1 lock held by udevd/84: [ 16.274110] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 16.274124] CPU: 0 PID: 84 Comm: udevd Tainted: G W 3.10.0 #407 [ 16.274128] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 16.274133] ffff88003de60240 ffff88001b2efc18 ffffffff816c0db1 ffff88001b2efc38 [ 16.274139] ffffffff81078647 ffff88003de60240 0000000000000010 ffff88001b2efcb8 [ 16.274145] ffffffff81180c9e 0000000000000005 0000000000000031 ffff88001b2efc68 [ 16.274150] Call Trace: [ 16.274160] [] dump_stack+0x19/0x1b [ 16.274175] [] might_sleep+0xe7/0x110 [ 16.274185] [] kmem_cache_alloc_node+0x4e/0x220 [ 16.274194] [] ? trace_hardirqs_on+0xd/0x10 [ 16.274203] [] ? alloc_skb+0x57/0x2a0 [ 16.274211] [] __alloc_skb+0x57/0x2a0 [ 16.274221] [] rnl_ipcm_sock_closed_notif_msg+0x39/0x140 [ 16.274230] [] kipcm_netlink_notify+0x4b/0xa0 [ 16.274238] [] ? skb_dequeue+0x67/0x90 [ 16.274246] [] notifier_call_chain+0x4d/0x70 [ 16.274254] [] atomic_notifier_call_chain+0x82/0xc0 [ 16.274262] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 16.274270] [] atomic_notifier_call_chain+0x16/0x20 [ 16.274279] [] netlink_release+0x282/0x2c0 [ 16.274287] [] sock_release+0x28/0x90 [ 16.274295] [] sock_close+0x12/0x20 [ 16.274304] [] fput+0xd3/0x260 [ 16.274317] [] ? close_fd+0x80/0xb0 [ 16.274320] [] __fput+0xe/0x10 [ 16.274323] [] task_work_run+0xb4/0xe0 [ 16.274326] [] do_notify_resume+0xaa/0xc0 [ 16.274328] [] int_signal+0x12/0x17 [ 16.274330] BUG: scheduling while atomic: udevd/84/0x10000002 [ 16.274683] 1 lock held by udevd/84: [ 16.274684] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 16.274689] Modules linked in: hid_generic usbhid hid ahci e1000 libahci [ 16.274695] CPU: 0 PID: 84 Comm: udevd Tainted: G W 3.10.0 #407 [ 16.274695] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 16.274696] 0000000000000000 ffff88001b2efb68 ffffffff816c0db1 ffff88001b2efb88 [ 16.274699] ffffffff816bbb12 0000000000000000 ffff88003fbd4000 ffff88001b2efc08 [ 16.274701] ffffffff816c7765 ffff88003f9fffc0 000000000000000b ffff88001b300000 [ 16.274703] Call Trace: [ 16.274706] [] dump_stack+0x19/0x1b [ 16.274708] [] __schedule_bug+0x63/0x73 [ 16.274711] [] schedule+0x7e5/0x8a0 [ 16.274714] [] cond_resched+0x2a/0x40 [ 16.274716] [] _cond_resched+0x32/0x40 [ 16.274718] [] kmem_cache_alloc_node+0x53/0x220 [ 16.274721] [] ? trace_hardirqs_on+0xd/0x10 [ 16.274723] [] ? alloc_skb+0x57/0x2a0 [ 16.274724] [] alloc_skb+0x57/0x2a0 [ 16.274728] [] rnl_ipcm_sock_closed_notif_msg+0x39/0x140 [ 16.274730] [] kipcm_netlink_notify+0x4b/0xa0 [ 16.274732] [] ? skb_dequeue+0x67/0x90 [ 16.274734] [] notifier_call_chain+0x4d/0x70 [ 16.274736] [] __atomic_notifier_call_chain+0x82/0xc0 [ 16.274738] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 16.274740] [] atomic_notifier_call_chain+0x16/0x20 [ 16.274742] [] netlink_release+0x282/0x2c0 [ 16.274744] [] sock_release+0x28/0x90 [ 16.274746] [] sock_close+0x12/0x20 [ 16.274748] [] fput+0xd3/0x260 [ 16.274750] [] ? close_fd+0x80/0xb0 [ 16.274752] [] __fput+0xe/0x10 [ 16.274754] [] task_work_run+0xb4/0xe0 [ 16.274757] [] do_notify_resume+0xaa/0xc0 [ 16.274759] [] int_signal+0x12/0x17 [ 16.274803] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.274804] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.274831] rina-netlink-utils: Could not send unicast msg: -111 [ 16.274832] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.275215] rina-netlink: Netlink socket at port-id 84 closed [ 16.275247] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.275248] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.275283] rina-netlink-utils: Could not send unicast msg: -111 [ 16.275284] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.278549] rina-netlink: Netlink socket at port-id -4097 closed [ 16.278571] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.278573] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.278599] rina-netlink-utils: Could not send unicast msg: -111 [ 16.278600] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.279746] rina-netlink: Netlink socket at port-id -4098 closed [ 16.279768] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.279769] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.279793] rina-netlink-utils: Could not send unicast msg: -111 [ 16.279794] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.287168] rina-netlink: Netlink socket at port-id -4099 closed [ 16.287192] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.287193] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.287219] rina-netlink-utils: Could not send unicast msg: -111 [ 16.287220] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.290855] rina-netlink: Netlink socket at port-id -4100 closed [ 16.290878] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.290879] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.290903] rina-netlink-utils: Could not send unicast msg: -111 [ 16.290904] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.295393] rina-netlink: Netlink socket at port-id -4102 closed [ 16.295416] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.295418] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.295443] rina-netlink-utils: Could not send unicast msg: -111 [ 16.295444] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.298682] rina-netlink: Netlink socket at port-id -4103 closed [ 16.298704] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.298706] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.298731] rina-netlink-utils: Could not send unicast msg: -111 [ 16.298732] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.299964] rina-netlink: Netlink socket at port-id -4104 closed [ 16.299986] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.299987] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.300012] rina-netlink-utils: Could not send unicast msg: -111 [ 16.300013] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.303945] rina-netlink: Netlink socket at port-id -4105 closed [ 16.303979] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.303981] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.304020] rina-netlink-utils: Could not send unicast msg: -111 [ 16.304022] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.311391] rina-netlink: Netlink socket at port-id -4106 closed [ 16.311395] BUG: scheduling while atomic: udevd/107/0x10000002 [ 16.311816] 1 lock held by udevd/107: [ 16.311818] #3: (rcu_read_lock){.+.+.+}, at: [] __atomic_notifier_call_chain+0x5/0xc0 [ 16.311829] Modules linked in: hid_generic usbhid hid ahci e1000 libahci [ 16.311840] CPU: 0 PID: 107 Comm: udevd Tainted: G W 3.10.0 #407 [ 16.311842] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 16.311844] 0000000000000000 ffff88001a905b68 ffffffff816c0db1 ffff88001a905b88 [ 16.311848] ffffffff816bbb12 0000000000000000 ffff88003fbd4000 ffff88001a905c08 [ 16.311853] ffffffff816c7765 ffff88001b7e4f90 ffff88001b7e4880 ffff88001b7e4880 [ 16.311861] Call Trace: [ 16.311876] [] dump_stack+0x19/0x1b [ 16.311890] [] schedule_bug+0x63/0x73 [ 16.311903] [] schedule+0x7e5/0x8a0 [ 16.311917] [] cond_resched+0x2a/0x40 [ 16.311931] [] ? vprintk_emit+0x1ce/0x5c0 [ 16.311941] [] _cond_resched+0x32/0x40 [ 16.311951] [] kmem_cache_alloc_node+0x53/0x220 [ 16.311961] [] ? trace_hardirqs_on+0xd/0x10 [ 16.311971] [] ? alloc_skb+0x57/0x2a0 [ 16.311980] [] __alloc_skb+0x57/0x2a0 [ 16.311990] [] rnl_ipcm_sock_closed_notif_msg+0x39/0x140 [ 16.312000] [] kipcm_netlink_notify+0x4b/0xa0 [ 16.312008] [] ? skb_dequeue+0x67/0x90 [ 16.314167] [] notifier_call_chain+0x4d/0x70 [ 16.314180] [] atomic_notifier_call_chain+0x82/0xc0 [ 16.314193] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 16.314206] [] atomic_notifier_call_chain+0x16/0x20 [ 16.314220] [] netlink_release+0x282/0x2c0 [ 16.314233] [] sock_release+0x28/0x90 [ 16.314243] [] sock_close+0x12/0x20 [ 16.314258] [] fput+0xd3/0x260 [ 16.314270] [] ? close_fd+0x80/0xb0 [ 16.314283] [] __fput+0xe/0x10 [ 16.314297] [] task_work_run+0xb4/0xe0 [ 16.314310] [] do_notify_resume+0xaa/0xc0 [ 16.314323] [] int_signal+0x12/0x17 [ 16.318166] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.318171] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.318342] rina-netlink-utils: Could not send unicast msg: -111 [ 16.318346] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.323752] rina-netlink: Netlink socket at port-id -4101 closed [ 16.323793] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.323795] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.323841] rina-netlink-utils: Could not send unicast msg: -111 [ 16.323843] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.331947] rina-netlink: Netlink socket at port-id -4107 closed [ 16.331953] BUG: scheduling while atomic: udevd/111/0x10000002 [ 16.332439] 1 lock held by udevd/111: [ 16.332441] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 16.332452] Modules linked in: hid_generic usbhid hid ahci e1000 libahci [ 16.332470] CPU: 0 PID: 111 Comm: udevd Tainted: G W 3.10.0 #407 [ 16.332472] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 16.332473] 0000000000000000 ffff88001b339b68 ffffffff816c0db1 ffff88001b339b88 [ 16.332478] ffffffff816bbb12 0000000000000000 ffff88003fbd4000 ffff88001b339c08 [ 16.332481] ffffffff816c7765 ffff88001b7e0710 ffff88001b7e0000 ffff88001b7e0000 [ 16.332485] Call Trace: [ 16.332489] [] dump_stack+0x19/0x1b [ 16.332494] [] __schedule_bug+0x63/0x73 [ 16.332498] [] schedule+0x7e5/0x8a0 [ 16.332502] [] cond_resched+0x2a/0x40 [ 16.332507] [] ? vprintk_emit+0x1ce/0x5c0 [ 16.332511] [] _cond_resched+0x32/0x40 [ 16.332515] [] kmem_cache_alloc_node+0x53/0x220 [ 16.332519] [] ? trace_hardirqs_on+0xd/0x10 [ 16.332524] [] ? __alloc_skb+0x57/0x2a0 [ 16.332526] [] alloc_skb+0x57/0x2a0 [ 16.332531] [] rnl_ipcm_sock_closed_notif_msg+0x39/0x140 [ 16.332535] [] kipcm_netlink_notify+0x4b/0xa0 [ 16.332538] [] ? skb_dequeue+0x67/0x90 [ 16.332541] [] notifier_call_chain+0x4d/0x70 [ 16.332544] [] atomic_notifier_call_chain+0x82/0xc0 [ 16.332547] [] ? __atomic_notifier_call_chain+0x5/0xc0 [ 16.332550] [] atomic_notifier_call_chain+0x16/0x20 [ 16.332553] [] netlink_release+0x282/0x2c0 [ 16.332557] [] sock_release+0x28/0x90 [ 16.332560] [] sock_close+0x12/0x20 [ 16.332564] [] fput+0xd3/0x260 [ 16.332568] [] ? close_fd+0x80/0xb0 [ 16.332571] [] ____fput+0xe/0x10 [ 16.332575] [] task_work_run+0xb4/0xe0 [ 16.332580] [] do_notify_resume+0xaa/0xc0 [ 16.332583] [] int_signal+0x12/0x17 [ 16.336011] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.336016] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.336067] rina-netlink-utils: Could not send unicast msg: -111 [ 16.336069] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.343017] rina-netlink: Netlink socket at port-id -4108 closed [ 16.343050] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.343052] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.343083] rina-netlink-utils: Could not send unicast msg: -111 [ 16.343084] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.346317] rina-netlink: Netlink socket at port-id -4109 closed [ 16.346343] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.346344] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.346372] rina-netlink-utils: Could not send unicast msg: -111 [ 16.346373] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.347657] rina-netlink: Netlink socket at port-id -4110 closed [ 16.347681] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.347682] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.347708] rina-netlink-utils: Could not send unicast msg: -111 [ 16.347709] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.350853] rina-netlink: Netlink socket at port-id -4111 closed [ 16.350877] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.350878] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.350904] rina-netlink-utils: Could not send unicast msg: -111 [ 16.350905] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.362412] rina-netlink: Netlink socket at port-id -4112 closed [ 16.362435] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.362436] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.362462] rina-netlink-utils: Could not send unicast msg: -111 [ 16.362463] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.363749] rina-netlink: Netlink socket at port-id -4113 closed [ 16.363773] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.363774] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.363799] rina-netlink-utils: Could not send unicast msg: -111 [ 16.363800] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.367970] rina-netlink: Netlink socket at port-id -4114 closed [ 16.368000] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.368002] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.368032] rina-netlink-utils: Could not send unicast msg: -111 [ 16.368034] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.371776] rina-netlink: Netlink socket at port-id -4115 closed [ 16.371809] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.371811] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.371852] rina-netlink-utils: Could not send unicast msg: -111 [ 16.371854] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.375919] rina-netlink: Netlink socket at port-id -4116 closed [ 16.375947] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.375949] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.375977] rina-netlink-utils: Could not send unicast msg: -111 [ 16.375978] rina-netlink: Error notifying IPC Manager in user space, -1 [ 16.386749] rina-netlink: Netlink socket at port-id -4117 closed [ 16.386844] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 16.386848] rina-netlink-utils: Result of genlmesg_end: 32 [ 16.387024] rina-netlink-utils: Could not send unicast msg: -111 [ 16.387028] rina-netlink: Error notifying IPC Manager in user space, -1 [ 20.007707] mount (292) used greatest stack depth: 3008 bytes left [ 20.731218] udevd[329]: starting version 175 [ 23.071120] input: PC Speaker as /devices/platform/pcspkr/input/input4 [ 23.082559] piix4_smbus 0000:00:07.0: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr [ 23.610867] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input5 [ 25.298879] microcode: CPU0 sig=0x306a9, pf=0x1, revision=0x0 [ 26.034750] microcode: Microcode Update Driver: v2.00 tigran@aivazian.fsnet.co.uk, Peter Oruba [ 26.446911] echo (527) used greatest stack depth: 2960 bytes left [ 29.531351] Adding 392188k swap on /dev/sda5. Priority:-1 extents:1 across:392188k FS [ 29.818427] EXT4-fs (sda1): re-mounted. Opts: (null) [ 30.058190] rina-netlink: Netlink socket at port-id -4157 closed [ 30.058206] BUG: sleeping function called from invalid context at mm/slub.c:926 [ 30.058656] in_atomic(): 1, irqs_disabled(): 0, pid: 459, name: udevd [ 30.059035] 1 lock held by udevd/459: [ 30.059039] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 30.059058] CPU: 0 PID: 459 Comm: udevd Tainted: G W 3.10.0 #407 [ 30.059059] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 30.059060] ffff88003de60240 ffff88003237dc18 ffffffff816c0db1 ffff88003237dc38 [ 30.059063] ffffffff81078647 ffff88003de60240 0000000000000010 ffff88003237dcb8 [ 30.059066] ffffffff81180c9e 0000000000000005 0000000000000034 ffff88003237dc68 [ 30.059068] Call Trace: [ 30.059072] [] dump_stack+0x19/0x1b [ 30.059076] [] might_sleep+0xe7/0x110 [ 30.059079] [] kmem_cache_alloc_node+0x4e/0x220 [ 30.059083] [] ? trace_hardirqs_on+0xd/0x10 [ 30.059086] [] ? alloc_skb+0x57/0x2a0 [ 30.059088] [] alloc_skb+0x57/0x2a0 [ 30.059092] [] rnl_ipcm_sock_closed_notif_msg+0x39/0x140 [ 30.059095] [] kipcm_netlink_notify+0x4b/0xa0 [ 30.059097] [] ? skb_dequeue+0x67/0x90 [ 30.059100] [] notifier_call_chain+0x4d/0x70 [ 30.059102] [] __atomic_notifier_call_chain+0x82/0xc0 [ 30.059104] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 30.059106] [] atomic_notifier_call_chain+0x16/0x20 [ 30.059114] [] netlink_release+0x282/0x2c0 [ 30.059117] [] sock_release+0x28/0x90 [ 30.059119] [] sock_close+0x12/0x20 [ 30.059123] [] fput+0xd3/0x260 [ 30.059125] [] ? close_fd+0x80/0xb0 [ 30.059127] [] __fput+0xe/0x10 [ 30.059131] [] task_work_run+0xb4/0xe0 [ 30.059134] [] do_notify_resume+0xaa/0xc0 [ 30.059136] [] int_signal+0x12/0x17 [ 30.059139] BUG: scheduling while atomic: udevd/459/0x10000002 [ 30.059500] 1 lock held by udevd/459: [ 30.059501] #3: (rcu_read_lock){.+.+.+}, at: [] __atomic_notifier_call_chain+0x5/0xc0 [ 30.059507] Modules linked in: microcode psmouse serio_raw i2c_piix4 pcspkr hid_generic usbhid hid ahci e1000 libahci [ 30.059517] CPU: 0 PID: 459 Comm: udevd Tainted: G W 3.10.0 #407 [ 30.059518] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 30.059519] 0000000000000000 ffff88003237db68 ffffffff816c0db1 ffff88003237db88 [ 30.059522] ffffffff816bbb12 0000000000000000 ffff88003fbd4000 ffff88003237dc08 [ 30.059524] ffffffff816c7765 ffff88003f9fffc0 000000000000000b ffff8800338a0000 [ 30.059526] Call Trace: [ 30.059529] [] dump_stack+0x19/0x1b [ 30.059537] [] schedule_bug+0x63/0x73 [ 30.059541] [] schedule+0x7e5/0x8a0 [ 30.059544] [] cond_resched+0x2a/0x40 [ 30.059547] [] _cond_resched+0x32/0x40 [ 30.059550] [] kmem_cache_alloc_node+0x53/0x220 [ 30.059553] [] ? trace_hardirqs_on+0xd/0x10 [ 30.059556] [] ? alloc_skb+0x57/0x2a0 [ 30.059558] [] __alloc_skb+0x57/0x2a0 [ 30.059561] [] rnl_ipcm_sock_closed_notif_msg+0x39/0x140 [ 30.059564] [] kipcm_netlink_notify+0x4b/0xa0 [ 30.059566] [] ? skb_dequeue+0x67/0x90 [ 30.059568] [] notifier_call_chain+0x4d/0x70 [ 30.059570] [] atomic_notifier_call_chain+0x82/0xc0 [ 30.059572] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 30.059575] [] atomic_notifier_call_chain+0x16/0x20 [ 30.059577] [] netlink_release+0x282/0x2c0 [ 30.059579] [] sock_release+0x28/0x90 [ 30.059581] [] sock_close+0x12/0x20 [ 30.059584] [] fput+0xd3/0x260 [ 30.059587] [] ? close_fd+0x80/0xb0 [ 30.059589] [] __fput+0xe/0x10 [ 30.059596] [] task_work_run+0xb4/0xe0 [ 30.059601] [] do_notify_resume+0xaa/0xc0 [ 30.059604] [] int_signal+0x12/0x17 [ 30.063740] rina-netlink: Netlink socket at port-id 329 closed [ 30.063798] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.063801] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.063864] rina-netlink-utils: Could not send unicast msg: -111 [ 30.063867] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.071509] rina-netlink: Netlink socket at port-id -4118 closed [ 30.071540] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.071542] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.071581] rina-netlink-utils: Could not send unicast msg: -111 [ 30.071582] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.078374] rina-netlink: Netlink socket at port-id -4119 closed [ 30.078406] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.078407] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.078435] rina-netlink-utils: Could not send unicast msg: -111 [ 30.078436] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.083268] rina-netlink: Netlink socket at port-id -4120 closed [ 30.083299] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.083300] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.083327] rina-netlink-utils: Could not send unicast msg: -111 [ 30.083328] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.090870] rina-netlink: Netlink socket at port-id -4121 closed [ 30.090902] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.090903] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.090930] rina-netlink-utils: Could not send unicast msg: -111 [ 30.090932] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.098820] rina-netlink: Netlink socket at port-id -4122 closed [ 30.098848] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.098849] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.098885] rina-netlink-utils: Could not send unicast msg: -111 [ 30.098887] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.106520] rina-netlink: Netlink socket at port-id -4123 closed [ 30.106563] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.106566] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.106615] rina-netlink-utils: Could not send unicast msg: -111 [ 30.106617] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.114958] rina-netlink: Netlink socket at port-id -4124 closed [ 30.114987] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.114988] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.115027] rina-netlink-utils: Could not send unicast msg: -111 [ 30.115028] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.122643] rina-netlink: Netlink socket at port-id -4125 closed [ 30.122680] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.122681] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.122714] rina-netlink-utils: Could not send unicast msg: -111 [ 30.122715] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.134224] rina-netlink: Netlink socket at port-id -4126 closed [ 30.134268] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.134270] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.134308] rina-netlink-utils: Could not send unicast msg: -111 [ 30.134309] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.143472] rina-netlink: Netlink socket at port-id -4128 closed [ 30.143524] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.143526] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.143582] rina-netlink-utils: Could not send unicast msg: -111 [ 30.143584] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.146849] rina-netlink: Netlink socket at port-id -4129 closed [ 30.146878] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.146879] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.146917] rina-netlink-utils: Could not send unicast msg: -111 [ 30.146918] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.158624] rina-netlink: Netlink socket at port-id -4130 closed [ 30.158655] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.158657] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.158694] rina-netlink-utils: Could not send unicast msg: -111 [ 30.158695] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.166780] rina-netlink: Netlink socket at port-id -4131 closed [ 30.166811] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.166813] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.166839] rina-netlink-utils: Could not send unicast msg: -111 [ 30.166840] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.171516] rina-netlink: Netlink socket at port-id -4132 closed [ 30.171540] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.171541] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.171574] rina-netlink-utils: Could not send unicast msg: -111 [ 30.171575] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.178738] rina-netlink: Netlink socket at port-id -4133 closed [ 30.178768] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.178769] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.178795] rina-netlink-utils: Could not send unicast msg: -111 [ 30.178796] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.186892] rina-netlink: Netlink socket at port-id -4134 closed [ 30.186924] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.186926] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.186952] rina-netlink-utils: Could not send unicast msg: -111 [ 30.186953] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.194668] rina-netlink: Netlink socket at port-id -4135 closed [ 30.194700] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.194702] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.194730] rina-netlink-utils: Could not send unicast msg: -111 [ 30.194732] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.202655] rina-netlink: Netlink socket at port-id -4136 closed [ 30.202685] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.202687] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.202713] rina-netlink-utils: Could not send unicast msg: -111 [ 30.202714] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.210908] rina-netlink: Netlink socket at port-id -4137 closed [ 30.210932] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.210933] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.210959] rina-netlink-utils: Could not send unicast msg: -111 [ 30.210960] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.219000] rina-netlink: Netlink socket at port-id -4138 closed [ 30.219027] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.219028] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.219063] rina-netlink-utils: Could not send unicast msg: -111 [ 30.219064] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.226755] rina-netlink: Netlink socket at port-id -4139 closed [ 30.226781] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.226782] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.226809] rina-netlink-utils: Could not send unicast msg: -111 [ 30.226810] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.235150] rina-netlink: Netlink socket at port-id -4140 closed [ 30.235177] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.235178] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.235204] rina-netlink-utils: Could not send unicast msg: -111 [ 30.235205] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.242785] rina-netlink: Netlink socket at port-id -4141 closed [ 30.242810] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.242812] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.242838] rina-netlink-utils: Could not send unicast msg: -111 [ 30.242839] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.251380] rina-netlink: Netlink socket at port-id -4142 closed [ 30.251404] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.251406] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.251431] rina-netlink-utils: Could not send unicast msg: -111 [ 30.251432] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.259112] rina-netlink: Netlink socket at port-id -4143 closed [ 30.259143] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.259144] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.259171] rina-netlink-utils: Could not send unicast msg: -111 [ 30.259172] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.266693] rina-netlink: Netlink socket at port-id -4144 closed [ 30.266727] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.266728] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.266754] rina-netlink-utils: Could not send unicast msg: -111 [ 30.266755] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.271303] rina-netlink: Netlink socket at port-id -4145 closed [ 30.271326] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.271327] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.271352] rina-netlink-utils: Could not send unicast msg: -111 [ 30.271353] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.279996] rina-netlink: Netlink socket at port-id -4146 closed [ 30.280022] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.280024] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.280050] rina-netlink-utils: Could not send unicast msg: -111 [ 30.280052] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.286792] rina-netlink: Netlink socket at port-id -4147 closed [ 30.286816] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.286818] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.286843] rina-netlink-utils: Could not send unicast msg: -111 [ 30.286844] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.295391] rina-netlink: Netlink socket at port-id -4148 closed [ 30.295420] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.295422] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.295451] rina-netlink-utils: Could not send unicast msg: -111 [ 30.295452] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.302481] rina-netlink: Netlink socket at port-id -4149 closed [ 30.302509] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.302518] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.302548] rina-netlink-utils: Could not send unicast msg: -111 [ 30.302549] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.311360] rina-netlink: Netlink socket at port-id -4150 closed [ 30.311385] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.311386] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.311413] rina-netlink-utils: Could not send unicast msg: -111 [ 30.311414] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.314909] rina-netlink: Netlink socket at port-id -4151 closed [ 30.315000] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.315005] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.315064] rina-netlink-utils: Could not send unicast msg: -111 [ 30.315065] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.323050] rina-netlink: Netlink socket at port-id -4152 closed [ 30.323075] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.323076] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.323103] rina-netlink-utils: Could not send unicast msg: -111 [ 30.323104] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.331032] rina-netlink: Netlink socket at port-id -4153 closed [ 30.331058] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.331059] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.331085] rina-netlink-utils: Could not send unicast msg: -111 [ 30.331087] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.338811] rina-netlink: Netlink socket at port-id -4154 closed [ 30.338852] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.338854] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.338895] rina-netlink-utils: Could not send unicast msg: -111 [ 30.338897] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.347001] rina-netlink: Netlink socket at port-id -4155 closed [ 30.347033] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.347035] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.347064] rina-netlink-utils: Could not send unicast msg: -111 [ 30.347065] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.355196] rina-netlink: Netlink socket at port-id -4156 closed [ 30.355221] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.355222] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.355248] rina-netlink-utils: Could not send unicast msg: -111 [ 30.355249] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.370788] rina-netlink: Netlink socket at port-id -4127 closed [ 30.370823] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.370824] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.370860] rina-netlink-utils: Could not send unicast msg: -111 [ 30.370862] rina-netlink: Error notifying IPC Manager in user space, -1 [ 30.431534] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro [ 30.487301] rina-netlink-utils: Entring rnl_format_generic_u32_param_msg... [ 30.487305] rina-netlink-utils: Result of genlmesg_end: 32 [ 30.487343] rina-netlink-utils: Could not send unicast msg: -111 [ 30.487344] rina-netlink: Error notifying IPC Manager in user space, -1 [ 40.871776] rina-netlink: Netlink socket at port-id 1616 closed [ 40.871780] BUG: sleeping function c

kewinrausch commented 9 years ago

Comment by edugrasa Wednesday Sep 25, 2013 at 10:52 GMT


It looks like the issue is that I'm calling a function that can sleep from a context where this is forbidden:

"You are calling alloc_skb which in turn calls kmem_cache_alloc in interrupt context where things can't sleep and kmem_cache_alloc can sleep. The reason for this is that you are passing GFP_KERNEL to alloc_skb. Try passing GFP_ATOMIC instead.

Other alternative is to may be use a precreated pool of skbs - may be this can be done in driver init function or any other safe context. But I don't know how much feasible that is in your situation."

Trying with GFP_ATOMIC

kewinrausch commented 9 years ago

Comment by salvestrini Wednesday Sep 25, 2013 at 12:39 GMT


No, it seems it doesn't (completely) solve the issues I have ...

Probably some other GFP_ATOMIC must be added ... (probably to all RNL messages ???)

logs attached

Ciao, Francesco

rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.350451] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.350455] BUG: sleeping function called from invalid context at mm/slub.c:926 [ 13.350874] in_atomic(): 1, irqs_disabled(): 0, pid: 84, name: udevd [ 13.351218] 1 lock held by udevd/84: [ 13.351222] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 13.351234] CPU: 0 PID: 84 Comm: udevd Tainted: G W 3.10.0 #454 [ 13.351238] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 13.351242] ffff88003f402b40 ffff88001b2efb58 ffffffff816c0ac1 ffff88001b2efb78 [ 13.351252] ffffffff81078647 ffff88003f402b40 0000000000000010 ffff88001b2efc08 [ 13.351254] ffffffff8118394f 0000000000000001 0000000000000082 0000000000000000 [ 13.351257] Call Trace: [ 13.351260] [] dump_stack+0x19/0x1b [ 13.351270] [] might_sleep+0xe7/0x110 [ 13.351274] [] kmalloc_node_track_caller+0x6f/0x290 [ 13.351277] [] ? pskb_expand_head+0x6b/0x2e0 [ 13.351280] [] ? mark_held_locks+0x74/0x150 [ 13.351282] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 13.351284] [] pskb_expand_head+0x6b/0x2e0 [ 13.351286] [] netlink_trim+0x7f/0xc0 [ 13.351288] [] netlink_unicast+0x48/0x1e0 [ 13.351292] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 13.351294] [] kipcm_netlink_notify+0x32/0x80 [ 13.351296] [] notifier_call_chain+0x4d/0x70 [ 13.351298] [] atomic_notifier_call_chain+0x82/0xc0 [ 13.351300] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 13.351302] [] atomic_notifier_call_chain+0x16/0x20 [ 13.351304] [] netlink_release+0x282/0x2c0 [ 13.351306] [] sock_release+0x28/0x90 [ 13.351308] [] sock_close+0x12/0x20 [ 13.351310] [] fput+0xd3/0x260 [ 13.351312] [] ? close_fd+0x80/0xb0 [ 13.351315] [] ____fput+0xe/0x10 [ 13.351318] [] task_work_run+0xb4/0xe0 [ 13.351321] [] do_notify_resume+0xaa/0xc0 [ 13.351323] [] int_signal+0x12/0x17 [ 13.351351] rina-rnl-utils: Could not send unicast msg: -111 [ 13.351352] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.351590] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.351592] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.351615] rina-rnl-utils: Could not send unicast msg: -111 [ 13.351616] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.354946] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.354948] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.354972] rina-rnl-utils: Could not send unicast msg: -111 [ 13.354973] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.358813] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.358815] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.358839] rina-rnl-utils: Could not send unicast msg: -111 [ 13.358840] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.360030] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.360032] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.360056] rina-rnl-utils: Could not send unicast msg: -111 [ 13.360057] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.363813] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.363815] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.363848] rina-rnl-utils: Could not send unicast msg: -111 [ 13.363849] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.367750] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.367753] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.367778] rina-rnl-utils: Could not send unicast msg: -111 [ 13.367779] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.371542] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.371544] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.371568] rina-rnl-utils: Could not send unicast msg: -111 [ 13.371569] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.375123] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.375125] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.375149] rina-rnl-utils: Could not send unicast msg: -111 [ 13.375150] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.378677] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.378678] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.378702] rina-rnl-utils: Could not send unicast msg: -111 [ 13.378703] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.379853] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.379855] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.379879] rina-rnl-utils: Could not send unicast msg: -111 [ 13.379879] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.383629] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.383631] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.383656] rina-rnl-utils: Could not send unicast msg: -111 [ 13.383657] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.387355] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.387357] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.387381] rina-rnl-utils: Could not send unicast msg: -111 [ 13.387382] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.391015] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.391017] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.391042] rina-rnl-utils: Could not send unicast msg: -111 [ 13.391043] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.394941] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.394943] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.394967] rina-rnl-utils: Could not send unicast msg: -111 [ 13.394968] rina-rnl: Error notifying IPC Manager in user space,

On Wed, Sep 25, 2013 at 12:52 PM, Eduard Grasa notifications@github.comwrote:

It looks like the issue is that I'm calling a function that can sleep from a context where this is forbidden:

"You are calling alloc_skb which in turn calls kmem_cache_alloc in interrupt context where things can't sleep and kmem_cache_alloc can sleep. The reason for this is that you are passing GFP_KERNEL to alloc_skb. Try passing GFP_ATOMIC instead.

Other alternative is to may be use a precreated pool of skbs - may be this can be done in driver init function or any other safe context. But I don't know how much feasible that is in your situation."

Trying with GFP_ATOMIC

— Reply to this email directly or view it on GitHubhttps://github.com/dana-i2cat/irati/issues/65#issuecomment-25077128 .

[ 0.000000] Initializing cgroup subsys cpuset [ 0.000000] Initializing cgroup subsys cpu [ 0.000000] Initializing cgroup subsys cpuacct [ 0.000000] Linux version 3.10.0 (francesco@ikira) (gcc version 4.6.3 (Ubuntu/Linaro 4.6.3-1ubuntu5) ) #454 SMP Wed Sep 25 14:29:08 CEST 2013 [ 0.000000] Command line: BOOT_IMAGE=/boot/vmlinuz-3.10.0 root=UUID=84c09d8d-2d53-4687-bb61-913f38f8cd7f ro quiet [ 0.000000] KERNEL supported cpus: [ 0.000000] Intel GenuineIntel [ 0.000000] AMD AuthenticAMD [ 0.000000] Centaur CentaurHauls [ 0.000000] e820: BIOS-provided physical RAM map: [ 0.000000] BIOS-e820: [mem 0x0000000000000000-0x000000000009fbff] usable [ 0.000000] BIOS-e820: [mem 0x000000000009fc00-0x000000000009ffff] reserved [ 0.000000] BIOS-e820: [mem 0x00000000000f0000-0x00000000000fffff] reserved [ 0.000000] BIOS-e820: [mem 0x0000000000100000-0x000000003ffeffff] usable [ 0.000000] BIOS-e820: [mem 0x000000003fff0000-0x000000003fffffff] ACPI data [ 0.000000] BIOS-e820: [mem 0x00000000fffc0000-0x00000000ffffffff] reserved [ 0.000000] NX (Execute Disable) protection: active [ 0.000000] SMBIOS 2.5 present. [ 0.000000] DMI: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 0.000000] e820: update [mem 0x00000000-0x00000fff] usable ==> reserved [ 0.000000] e820: remove [mem 0x000a0000-0x000fffff] usable [ 0.000000] No AGP bridge found [ 0.000000] e820: last_pfn = 0x3fff0 max_arch_pfn = 0x400000000 [ 0.000000] MTRR default type: uncachable [ 0.000000] MTRR variable ranges disabled: [ 0.000000] x86 PAT enabled: cpu 0, old 0x7040600070406, new 0x7010600070106 [ 0.000000] CPU MTRRs all blank - virtualized system. [ 0.000000] Scanning 1 areas for low memory corruption [ 0.000000] Base memory trampoline at [ffff880000099000] 99000 size 24576 [ 0.000000] init_memory_mapping: [mem 0x00000000-0x000fffff] [ 0.000000] [mem 0x00000000-0x000fffff] page 4k [ 0.000000] BRK [0x02a1b000, 0x02a1bfff] PGTABLE [ 0.000000] BRK [0x02a1c000, 0x02a1cfff] PGTABLE [ 0.000000] BRK [0x02a1d000, 0x02a1dfff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x3fc00000-0x3fdfffff] [ 0.000000] [mem 0x3fc00000-0x3fdfffff] page 4k [ 0.000000] BRK [0x02a1e000, 0x02a1efff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x3c000000-0x3fbfffff] [ 0.000000] [mem 0x3c000000-0x3fbfffff] page 4k [ 0.000000] BRK [0x02a1f000, 0x02a1ffff] PGTABLE [ 0.000000] init_memory_mapping: [mem 0x00100000-0x3bffffff] [ 0.000000] [mem 0x00100000-0x3bffffff] page 4k [ 0.000000] init_memory_mapping: [mem 0x3fe00000-0x3ffeffff] [ 0.000000] [mem 0x3fe00000-0x3ffeffff] page 4k [ 0.000000] RAMDISK: [mem 0x2a516000-0x31282fff] [ 0.000000] ACPI: RSDP 00000000000e0000 00024 (v02 VBOX ) [ 0.000000] ACPI: XSDT 000000003fff0030 00034 (v01 VBOX VBOXXSDT 00000001 ASL 00000061) [ 0.000000] ACPI: FACP 000000003fff00f0 000F4 (v04 VBOX VBOXFACP 00000001 ASL 00000061) [ 0.000000] ACPI: DSDT 000000003fff0410 01B96 (v01 VBOX VBOXBIOS 00000002 INTL 20100528) [ 0.000000] ACPI: FACS 000000003fff0200 00040 [ 0.000000] ACPI: SSDT 000000003fff0240 001CC (v01 VBOX VBOXCPUT 00000002 INTL 20100528) [ 0.000000] No NUMA configuration found [ 0.000000] Faking a node at [mem 0x0000000000000000-0x000000003ffeffff] [ 0.000000] Initmem setup node 0 [mem 0x00000000-0x3ffeffff] [ 0.000000] NODE_DATA [mem 0x3ffeb000-0x3ffeffff] [ 0.000000] [ffffea0000000000-ffffea0000ffffff] PMD -> [ffff88003e400000-ffff88003f3fffff] on node 0 [ 0.000000] Zone ranges: [ 0.000000] DMA [mem 0x00001000-0x00ffffff] [ 0.000000] DMA32 [mem 0x01000000-0xffffffff] [ 0.000000] Normal empty [ 0.000000] Movable zone start for each node [ 0.000000] Early memory node ranges [ 0.000000] node 0: [mem 0x00001000-0x0009efff] [ 0.000000] node 0: [mem 0x00100000-0x3ffeffff] [ 0.000000] On node 0 totalpages: 262030 [ 0.000000] DMA zone: 64 pages used for memmap [ 0.000000] DMA zone: 21 pages reserved [ 0.000000] DMA zone: 3998 pages, LIFO batch:0 [ 0.000000] DMA32 zone: 4032 pages used for memmap [ 0.000000] DMA32 zone: 258032 pages, LIFO batch:31 [ 0.000000] ACPI: PM-Timer IO Port: 0x4008 [ 0.000000] smpboot: Allowing 1 CPUs, 0 hotplug CPUs [ 0.000000] nr_irqs_gsi: 16 [ 0.000000] PM: Registered nosave memory: 000000000009f000 - 00000000000a0000 [ 0.000000] PM: Registered nosave memory: 00000000000a0000 - 00000000000f0000 [ 0.000000] PM: Registered nosave memory: 00000000000f0000 - 0000000000100000 [ 0.000000] e820: [mem 0x40000000-0xfffbffff] available for PCI devices [ 0.000000] setup_percpu: NR_CPUS:256 nr_cpumask_bits:256 nr_cpu_ids:1 nr_node_ids:1 [ 0.000000] PERCPU: Embedded 476 pages/cpu @ffff88003fa00000 s1920640 r8192 d20864 u2097152 [ 0.000000] pcpu-alloc: s1920640 r8192 d20864 u2097152 alloc=1*2097152 [ 0.000000] pcpu-alloc: [0] 0 [ 0.000000] Built 1 zonelists in Node order, mobility grouping on. Total pages: 257913 [ 0.000000] Policy zone: DMA32 [ 0.000000] Kernel command line: BOOT_IMAGE=/boot/vmlinuz-3.10.0 root=UUID=84c09d8d-2d53-4687-bb61-913f38f8cd7f ro quiet [ 0.000000] PID hash table entries: 4096 (order: 3, 32768 bytes) [ 0.000000] Checking aperture... [ 0.000000] No AGP bridge found [ 0.000000] Calgary: detecting Calgary via BIOS EBDA area [ 0.000000] Calgary: Unable to locate Rio Grande table in EBDA - bailing! [ 0.000000] Memory: 888132k/1048512k available (7001k kernel code, 392k absent, 159988k reserved, 6351k data, 3028k init) [ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=1, Nodes=1 [ 0.000000] Hierarchical RCU implementation. [ 0.000000] RCU dyntick-idle grace-period acceleration is enabled. [ 0.000000] RCU restricting CPUs from NR_CPUS=256 to nr_cpu_ids=1. [ 0.000000] NR_IRQS:16640 nr_irqs:256 16 [ 0.000000] Console: colour VGA+ 80x25 [ 0.000000] console [tty0] enabled [ 0.000000] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar [ 0.000000] ... MAX_LOCKDEP_SUBCLASSES: 8 [ 0.000000] ... MAX_LOCK_DEPTH: 48 [ 0.000000] ... MAX_LOCKDEP_KEYS: 8191 [ 0.000000] ... CLASSHASH_SIZE: 4096 [ 0.000000] ... MAX_LOCKDEP_ENTRIES: 16384 [ 0.000000] ... MAX_LOCKDEP_CHAINS: 32768 [ 0.000000] ... CHAINHASH_SIZE: 16384 [ 0.000000] memory used by lock dependency info: 6367 kB [ 0.000000] per task-struct memory footprint: 2688 bytes [ 0.000000] tsc: Fast TSC calibration failed [ 0.000000] tsc: Unable to calibrate against PIT [ 0.000000] tsc: using PMTIMER reference calibration [ 0.000000] tsc: Detected 2877.530 MHz processor [ 0.016002] Calibrating delay loop (skipped), value calculated using timer frequency.. 5755.06 BogoMIPS (lpj=11510120) [ 0.016005] pid_max: default: 32768 minimum: 301 [ 0.016639] Security Framework initialized [ 0.016719] AppArmor: AppArmor initialized [ 0.021995] Dentry cache hash table entries: 131072 (order: 8, 1048576 bytes) [ 0.023125] Inode-cache hash table entries: 65536 (order: 7, 524288 bytes) [ 0.023310] Mount-cache hash table entries: 256 [ 0.026155] Initializing cgroup subsys devices [ 0.026230] Initializing cgroup subsys freezer [ 0.026261] Initializing cgroup subsys blkio [ 0.026264] Initializing cgroup subsys perf_event [ 0.026922] mce: CPU supports 0 MCE banks [ 0.027035] Last level iTLB entries: 4KB 512, 2MB 0, 4MB 0 [ 0.027035] Last level dTLB entries: 4KB 512, 2MB 32, 4MB 32 [ 0.027035] tlb_flushall_shift: 1 [ 0.048004] debug: unmapping init [mem 0xffffffff82001000-0xffffffff82006fff] [ 0.048367] ACPI: Core revision 20130328 [ 0.123712] ACPI: All ACPI Tables successfully acquired [ 0.123732] ACPI: setting ELCR to 0200 (from 0e20) [ 0.123786] ftrace: allocating 25662 entries in 101 pages [ 0.136623] smpboot: weird, boot CPU (#3) not listed by the BIOS [ 0.136629] smpboot: SMP motherboard not detected [ 0.140000] ------------[ cut here ]------------ [ 0.140000] WARNING: at kernel/time/clockevents.c:46 clockevent_delta2ns+0x6b/0x80() [ 0.140000] Modules linked in: [ 0.140000] CPU: 0 PID: 1 Comm: swapper/0 Not tainted 3.10.0 #454 [ 0.140000] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 0.140000] ffffffff81a27beb ffff88003dcb1de8 ffffffff816c0ac1 ffff88003dcb1e28 [ 0.140000] ffffffff81043f10 0000000000000000 ffffffff81c1fb40 0000000000000000 [ 0.140000] 00000000114b573d 0000000000000000 000000000005806f ffff88003dcb1e38 [ 0.140000] Call Trace: [ 0.140000] [] dump_stack+0x19/0x1b [ 0.140000] [] warn_slowpath_common+0x70/0xa0 [ 0.140000] [] warn_slowpath_null+0x1a/0x20 [ 0.140000] [] clockevent_delta2ns+0x6b/0x80 [ 0.140000] [] ? setup_boot_APIC_clock+0x142/0x4f1 [ 0.140000] [] setup_boot_APIC_clock+0x2c2/0x4f1 [ 0.140000] [] APIC_init_uniprocessor+0xf9/0xfd [ 0.140000] [] native_smp_prepare_cpus+0x210/0x453 [ 0.140000] [] kernel_init_freeable+0x8d/0x1cb [ 0.140000] [] ? rest_init+0xe0/0xe0 [ 0.140000] [] kernel_init+0xe/0xf0 [ 0.140000] [] ret_from_fork+0x7c/0xb0 [ 0.140000] [] ? rest_init+0xe0/0xe0 [ 0.140000] ---[ end trace 0a53fc0c19ea7129 ]--- [ 0.140000] APIC frequency too slow, disabling apic timer [ 0.140000] smpboot: SMP disabled [ 0.140000] Performance Events: unsupported p6 CPU model 58 no PMU driver, software events only. [ 0.140314] Brought up 1 CPUs [ 0.140318] smpboot: Total of 1 processors activated (5755.06 BogoMIPS) [ 0.140946] NMI watchdog: disabled (cpu0): hardware events not enabled [ 0.142046] devtmpfs: initialized [ 0.154216] EVM: security.selinux [ 0.154219] EVM: security.SMACK64 [ 0.154220] EVM: security.capability [ 0.176830] regulator-dummy: no parameters [ 0.177831] RTC time: 12:31:37, date: 09/25/13 [ 0.178630] NET: Registered protocol family 16 [ 0.181865] ACPI: bus type PCI registered [ 0.182843] PCI: Using configuration type 1 for base access [ 0.219647] bio: create slab at 0 [ 0.222048] ACPI: Added _OSI(Module Device) [ 0.222064] ACPI: Added _OSI(Processor Device) [ 0.222078] ACPI: Added _OSI(3.0 _SCP Extensions) [ 0.222102] ACPI: Added _OSI(Processor Aggregator Device) [ 0.225578] ACPI: EC: Look up EC in DSDT [ 0.231234] ACPI: Executed 1 blocks of module-level executable AML code [ 0.459093] ACPI: Interpreter enabled [ 0.459115] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S1 [ 0.459139] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S2 [ 0.459162] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S3 [ 0.459200] ACPI Exception: AE_NOT_FOUND, While evaluating Sleep State S4 [ 0.459250] ACPI: (supports S0 S5) [ 0.459252] ACPI: Using PIC for interrupt routing [ 0.471418] PCI: Ignoring host bridge windows from ACPI; if necessary, use "pci=use_crs" and report a bug [ 0.474327] ACPI: No dock devices found. [ 0.635176] ACPI: PCI Root Bridge [PCI0](domain 0000 [bus 00-ff]) [ 0.639043] acpi PNP0A03:00: host bridge window io 0x0000-0x0cf7 [ 0.639046] acpi PNP0A03:00: host bridge window io 0x0d00-0xffff [ 0.639047] acpi PNP0A03:00: host bridge window mem 0x000a0000-0x000bffff [ 0.639049] acpi PNP0A03:00: host bridge window mem 0x40000000-0xffdfffff [ 0.639073] PCI: root bus 00: using default resources [ 0.639113] acpi PNP0A03:00: fail to add MMCONFIG information, can't access extended PCI configuration space under this bridge. [ 0.640860] PCI host bridge to bus 0000:00 [ 0.640884] pci_bus 0000:00: root bus resource [bus 00-ff] [ 0.640898] pci_bus 0000:00: root bus resource [io 0x0000-0xffff] [ 0.640910] pci_bus 0000:00: root bus resource [mem 0x00000000-0xfffffffff] [ 0.641029] pci 0000:00:00.0: [8086:1237] type 00 class 0x060000 [ 0.643100] pci 0000:00:01.0: [8086:7000] type 00 class 0x060100 [ 0.644890] pci 0000:00:01.1: [8086:7111] type 00 class 0x01018a [ 0.645320] pci 0000:00:01.1: reg 20: [io 0xd000-0xd00f] [ 0.647737] pci 0000:00:02.0: [80ee:beef] type 00 class 0x030000 [ 0.648695] pci 0000:00:02.0: reg 10: [mem 0xe0000000-0xe0ffffff pref] [ 0.659563] pci 0000:00:03.0: [8086:100e] type 00 class 0x020000 [ 0.660202] pci 0000:00:03.0: reg 10: [mem 0xf0000000-0xf001ffff] [ 0.661951] pci 0000:00:03.0: reg 18: [io 0xd010-0xd017] [ 0.669243] pci 0000:00:04.0: [80ee:cafe] type 00 class 0x088000 [ 0.670061] pci 0000:00:04.0: reg 10: [io 0xd020-0xd03f] [ 0.670833] pci 0000:00:04.0: reg 14: [mem 0xf0400000-0xf07fffff] [ 0.671526] pci 0000:00:04.0: reg 18: [mem 0xf0800000-0xf0803fff pref] [ 0.678655] pci 0000:00:05.0: [8086:2415] type 00 class 0x040100 [ 0.678764] pci 0000:00:05.0: reg 10: [io 0xd100-0xd1ff] [ 0.678838] pci 0000:00:05.0: reg 14: [io 0xd200-0xd23f] [ 0.682480] pci 0000:00:06.0: [106b:003f] type 00 class 0x0c0310 [ 0.683717] pci 0000:00:06.0: reg 10: [mem 0xf0804000-0xf0804fff] [ 0.690794] pci 0000:00:07.0: [8086:7113] type 00 class 0x068000 [ 0.694749] pci 0000:00:0d.0: [8086:2829] type 00 class 0x010601 [ 0.696638] pci 0000:00:0d.0: reg 10: [io 0xd240-0xd247] [ 0.698226] pci 0000:00:0d.0: reg 18: [io 0xd250-0xd257] [ 0.700215] pci 0000:00:0d.0: reg 20: [io 0xd260-0xd26f] [ 0.701042] pci 0000:00:0d.0: reg 24: [mem 0xf0806000-0xf0807fff] [ 0.705145] acpi PNP0A03:00: ACPI _OSC support notification failed, disabling PCIe ASPM [ 0.705148] acpi PNP0A03:00: Unable to request _OSC control (_OSC support mask: 0x08) [ 0.767118] ACPI: PCI Interrupt Link [LNKA](IRQs 5 9 10 11) [ 0.785510] ACPI: PCI Interrupt Link [LNKB](IRQs 5 9 10 11) [ 0.791290] ACPI: PCI Interrupt Link [LNKC](IRQs 5 9 10 11) [ 0.795450] ACPI: PCI Interrupt Link [LNKD](IRQs 5 9 10 11) [ 0.797875] ACPI: Enabled 1 GPEs in block 00 to 07 [ 0.797896] acpi root: SB.PCI0 notify handler is installed [ 0.797945] Found 1 acpi root devices [ 0.799215] vgaarb: device added: PCI:0000:00:02.0,decodes=io+mem,owns=io+mem,locks=none [ 0.799221] vgaarb: loaded [ 0.799222] vgaarb: bridge control possible 0000:00:02.0 [ 0.806038] SCSI subsystem initialized [ 0.806047] ACPI: bus type ATA registered [ 0.806416] libata version 3.00 loaded. [ 0.806769] ACPI: bus type USB registered [ 0.807166] usbcore: registered new interface driver usbfs [ 0.807337] usbcore: registered new interface driver hub [ 0.807532] usbcore: registered new device driver usb [ 0.809084] PCI: Using ACPI for IRQ routing [ 0.809086] PCI: pci_cache_line_size set to 64 bytes [ 0.809271] e820: reserve RAM buffer [mem 0x0009fc00-0x0009ffff] [ 0.809302] e820: reserve RAM buffer [mem 0x3fff0000-0x3fffffff] [ 0.812185] NetLabel: Initializing [ 0.812190] NetLabel: domain hash size = 128 [ 0.812194] NetLabel: protocols = UNLABELED CIPSOv4 [ 0.812585] NetLabel: unlabeled traffic allowed by default [ 0.812613] Switching to clocksource refined-jiffies [ 0.969310] AppArmor: AppArmor Filesystem Enabled [ 0.969567] pnp: PnP ACPI init [ 0.969746] ACPI: bus type PNP registered [ 0.970593] pnp 00:00: Plug and Play ACPI device, IDs PNP0303 (active) [ 0.970806] pnp 00:01: [dma 4] [ 0.972445] pnp 00:01: Plug and Play ACPI device, IDs PNP0200 (active) [ 0.973560] pnp 00:02: Plug and Play ACPI device, IDs PNP0f03 (active) [ 0.974423] pnp 00:03: Plug and Play ACPI device, IDs PNP0400 (active) [ 0.992878] pnp: PnP ACPI: found 4 devices [ 0.992880] ACPI: bus type PNP unregistered [ 1.032803] Switching to clocksource acpi_pm [ 1.032839] pci_bus 0000:00: resource 4 [io 0x0000-0xffff] [ 1.032841] pci_bus 0000:00: resource 5 [mem 0x00000000-0xfffffffff] [ 1.033171] NET: Registered protocol family 2 [ 1.034944] TCP established hash table entries: 8192 (order: 5, 131072 bytes) [ 1.036013] TCP bind hash table entries: 8192 (order: 7, 655360 bytes) [ 1.036013] TCP: Hash tables configured (established 8192 bind 8192) [ 1.038763] TCP: reno registered [ 1.039061] UDP hash table entries: 512 (order: 4, 98304 bytes) [ 1.039296] UDP-Lite hash table entries: 512 (order: 4, 98304 bytes) [ 1.039902] NET: Registered protocol family 1 [ 1.039979] pci 0000:00:00.0: Limiting direct PCI/PCI transfers [ 1.040009] pci 0000:00:01.0: Activating ISA DMA hang workarounds [ 1.041987] pci 0000:00:02.0: Boot video device [ 1.179859] ACPI: PCI Interrupt Link [LNKB] enabled at IRQ 11 [ 1.179863] PCI: setting IRQ 11 as level-triggered [ 1.351806] PCI: CLS 0 bytes, default 64 [ 1.354738] Trying to unpack rootfs image as initramfs... [ 6.647519] debug: unmapping init [mem 0xffff88002a516000-0xffff880031282fff] [ 6.651600] platform rtc_cmos: registered platform RTC device (no PNP device found) [ 6.654521] Scanning for low memory corruption every 60 seconds [ 6.658962] audit: initializing netlink socket (disabled) [ 6.659061] type=2000 audit(1380112302.655:1): initialized [ 6.702814] bounce pool size: 64 pages [ 6.702959] HugeTLB registered 2 MB page size, pre-allocated 0 pages [ 6.826946] VFS: Disk quotas dquot_6.5.2 [ 6.827565] Dquot-cache hash table entries: 512 (order 0, 4096 bytes) [ 6.874615] fuse init (API version 7.22) [ 6.875990] msgmni has been set to 1734 [ 6.879745] cryptomgr_test (30) used greatest stack depth: 6288 bytes left [ 6.883306] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 252) [ 6.883489] io scheduler noop registered [ 6.883491] io scheduler deadline registered (default) [ 6.886964] io scheduler cfq registered [ 6.890948] pci_hotplug: PCI Hot Plug PCI Core version: 0.5 [ 6.891289] pciehp: PCI Express Hot Plug Controller Driver version: 0.4 [ 6.898424] ACPI: AC Adapter AC [ 6.899964] input: Power Button as /devices/LNXSYSTM:00/LNXPWRBN:00/input/input0 [ 6.900007] ACPI: Power Button [PWRF] [ 6.902800] input: Sleep Button as /devices/LNXSYSTM:00/LNXSLPBN:00/input/input1 [ 6.902818] ACPI: Sleep Button [SLPF] [ 7.022937] GHES: HEST is not enabled! [ 7.023642] Serial: 8250/16550 driver, 32 ports, IRQ sharing enabled [ 7.150672] Linux agpgart interface v0.103 [ 7.176064] ACPI: Battery Slot [BAT0](battery present) [ 7.230616] brd: module loaded [ 7.266806] loop: module loaded [ 7.274352] ata_piix 0000:00:01.1: version 2.13 [ 7.287478] scsi0 : ata_piix [ 7.294924] scsi1 : ata_piix [ 7.296017] ata1: PATA max UDMA/33 cmd 0x1f0 ctl 0x3f6 bmdma 0xd000 irq 14 [ 7.296019] ata2: PATA max UDMA/33 cmd 0x170 ctl 0x376 bmdma 0xd008 irq 15 [ 7.311573] libphy: Fixed MDIO Bus: probed [ 7.315352] tun: Universal TUN/TAP device driver, 1.6 [ 7.315354] tun: (C) 1999-2004 Max Krasnyansky maxk@qualcomm.com [ 7.315927] PPP generic driver version 2.4.2 [ 7.318511] ehci_hcd: USB 2.0 'Enhanced' Host Controller (EHCI) Driver [ 7.318512] ehci-pci: EHCI PCI platform driver [ 7.318622] ehci-platform: EHCI generic platform driver [ 7.318737] ohci_hcd: USB 1.1 'Open' Host Controller (OHCI) Driver [ 7.426589] ohci_hcd 0000:00:06.0: OHCI Host Controller [ 7.426735] ohci_hcd 0000:00:06.0: new USB bus registered, assigned bus number 1 [ 7.426886] ohci_hcd 0000:00:06.0: irq 11, io mem 0xf0804000 [ 7.466378] ata2.00: ATAPI: VBOX CD-ROM, 1.0, max UDMA/133 [ 7.467499] ata2.00: configured for UDMA/33 [ 7.481675] scsi 1:0:0:0: CD-ROM VBOX CD-ROM 1.0 PQ: 0 ANSI: 5 [ 7.482379] usb usb1: New USB device found, idVendor=1d6b, idProduct=0001 [ 7.482381] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1 [ 7.482383] usb usb1: Product: OHCI Host Controller [ 7.482384] usb usb1: Manufacturer: Linux 3.10.0 ohci_hcd [ 7.482385] usb usb1: SerialNumber: 0000:00:06.0 [ 7.486443] hub 1-0:1.0: USB hub found [ 7.486574] hub 1-0:1.0: 8 ports detected [ 7.499134] sr0: scsi3-mmc drive: 32x/32x xa/form2 tray [ 7.499144] cdrom: Uniform CD-ROM driver Revision: 3.20 [ 7.507588] sr 1:0:0:0: Attached scsi CD-ROM sr0 [ 7.512074] sr 1:0:0:0: Attached scsi generic sg0 type 5 [ 7.519643] uhci_hcd: USB Universal Host Controller Interface driver [ 7.523976] i8042: PNP: PS/2 Controller [PNP0303:PS2K,PNP0f03:PS2M] at 0x60,0x64 irq 1,12 [ 8.073375] tsc: Refined TSC clocksource calibration: 2879.381 MHz [ 8.073387] Switching to clocksource tsc [ 8.073614] serio: i8042 KBD port at 0x60,0x64 irq 1 [ 8.073672] serio: i8042 AUX port at 0x60,0x64 irq 12 [ 8.075896] mousedev: PS/2 mouse device common for all mice [ 8.083609] input: AT Translated Set 2 keyboard as /devices/platform/i8042/serio0/input/input2 [ 8.090439] rtc_cmos rtc_cmos: rtc core: registered rtc_cmos as rtc0 [ 8.090532] rtc_cmos rtc_cmos: alarms up to one day, 114 bytes nvram [ 8.091992] device-mapper: uevent: version 1.0.3 [ 8.095298] device-mapper: ioctl: 4.24.0-ioctl (2013-01-15) initialised: dm-devel@redhat.com [ 8.095322] cpuidle: using governor ladder [ 8.095324] cpuidle: using governor menu [ 8.099552] ashmem: initialized [ 8.102865] TCP: cubic registered [ 8.107600] NET: Registered protocol family 10 [ 8.114760] NET: Registered protocol family 17 [ 8.114882] Key type dns_resolver registered [ 8.114884] rina-core: RINA stack initializing [ 8.114885] rina-debug: Debugging facilities initializing [ 8.114912] rina-debug: Debug-fs support initialized successfully [ 8.114912] rina-debug: Debugging facilities initialized successfully [ 8.114913] rina-core: Creating root kset [ 8.114945] rina-core: Creating sysfs group [ 8.114954] rina-rnl: Initializing Netlink layer [ 8.115017] rina-rnl: Registering Family returned: 0 [ 8.115018] rina-rnl: Family registered with id: 24 [ 8.115025] rina-rnl: NetLink layer initialized successfully [ 8.115026] rina-personality: Initializing personality layer [ 8.115067] rina-personality: Personality layer initialized successfully [ 8.115068] rina-core: RINA stack v0.1.4 initialized [ 8.119197] PM: Hibernation image not present or could not be loaded. [ 8.119315] registered taskstats version 1 [ 8.119548] kmemleak: Kernel memory leak detector initialized [ 8.119763] kmemleak: Automatic memory scanning thread started [ 8.127848] modprobe (47) used greatest stack depth: 4000 bytes left [ 8.135528] Key type trusted registered [ 8.151673] Key type encrypted registered [ 8.170874] Magic number: 13:646:532 [ 8.170895] bdi 1:10: hash matches [ 8.170904] tty ttyS12: hash matches [ 8.171011] rtc_cmos rtc_cmos: setting system clock to 2013-09-25 12:31:45 UTC (1380112305) [ 8.171393] BIOS EDD facility v0.16 2004-Jun-25, 0 devices found [ 8.171394] EDD information not available. [ 8.178356] debug: unmapping init [mem 0xffffffff81d0c000-0xffffffff82000fff] [ 8.178415] Write protecting the kernel read-only data: 12288k [ 8.178559] debug: unmapping init [mem 0xffff8800016d9000-0xffff8800017fffff] [ 8.178609] debug: unmapping init [mem 0xffff880001b01000-0xffff880001bfffff] [ 8.287975] udevd[84]: starting version 175 [ 8.382100] usb 1-1: new full-speed USB device number 2 using ohci_hcd [ 8.651784] usb 1-1: New USB device found, idVendor=80ee, idProduct=0021 [ 8.651787] usb 1-1: New USB device strings: Mfr=1, Product=3, SerialNumber=0 [ 8.651788] usb 1-1: Product: USB Tablet [ 8.651790] usb 1-1: Manufacturer: VirtualBox [ 9.331702] ata_id (119) used greatest stack depth: 3184 bytes left [ 9.427172] e1000: Intel(R) PRO/1000 Network Driver - version 7.3.21-k8-NAPI [ 9.427175] e1000: Copyright (c) 1999-2006 Intel Corporation. [ 11.231569] ACPI: PCI Interrupt Link [LNKC] enabled at IRQ 10 [ 11.231573] PCI: setting IRQ 10 as level-triggered [ 11.243365] hidraw: raw HID events driver (C) Jiri Kosina [ 11.950553] usbcore: registered new interface driver usbhid [ 11.950556] usbhid: USB HID core driver [ 11.995273] e1000 0000:00:03.0 eth0: (PCI:33MHz:32-bit) 08:00:27:70:f3:97 [ 11.995304] e1000 0000:00:03.0 eth0: Intel(R) PRO/1000 Network Connection [ 11.995420] ahci 0000:00:0d.0: version 3.0 [ 12.035482] input: VirtualBox USB Tablet as /devices/pci0000:00/0000:00:06.0/usb1/1-1/1-1:1.0/input/input3 [ 12.042662] hid-generic 0003:80EE:0021.0001: input,hidraw0: USB HID v1.10 Mouse [VirtualBox USB Tablet] on usb-0000:00:06.0-1/input0 [ 12.358825] ACPI: PCI Interrupt Link [LNKA] enabled at IRQ 5 [ 12.358830] PCI: setting IRQ 5 as level-triggered [ 12.359089] ahci: SSS flag set, parallel bus scan disabled [ 12.359279] ahci 0000:00:0d.0: AHCI 0001.0100 32 slots 1 ports 3 Gbps 0x1 impl SATA mode [ 12.359282] ahci 0000:00:0d.0: flags: 64bit ncq stag only ccc [ 12.367829] scsi2 : ahci [ 12.371751] ata3: SATA max UDMA/133 abar m8192@0xf0806000 port 0xf0806100 irq 5 [ 12.701505] ata3: SATA link up 3.0 Gbps (SStatus 123 SControl 300) [ 12.701595] ata3.00: ATA-6: VBOX HARDDISK, 1.0, max UDMA/133 [ 12.701597] ata3.00: 16777216 sectors, multi 128: LBA48 NCQ (depth 31/32) [ 12.701708] ata3.00: configured for UDMA/133 [ 12.702471] scsi 2:0:0:0: Direct-Access ATA VBOX HARDDISK 1.0 PQ: 0 ANSI: 5 [ 12.707594] sd 2:0:0:0: [sda] 16777216 512-byte logical blocks: (8.58 GB/8.00 GiB) [ 12.710860] sd 2:0:0:0: [sda] Write Protect is off [ 12.710863] sd 2:0:0:0: [sda] Mode Sense: 00 3a 00 00 [ 12.711235] sd 2:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA [ 12.719030] sd 2:0:0:0: Attached scsi generic sg1 type 0 [ 12.731683] sda: sda1 sda2 < sda5 > [ 12.746820] sd 2:0:0:0: [sda] Attached SCSI disk [ 13.279468] PM: Starting manual resume from disk [ 13.279475] PM: Hibernation image partition 8:5 present [ 13.279476] PM: Looking for hibernation image. [ 13.282556] PM: Image not found (code -22) [ 13.282559] PM: Hibernation image not present or could not be loaded. [ 13.331106] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null) [ 13.350447] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.350451] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.350455] BUG: sleeping function called from invalid context at mm/slub.c:926 [ 13.350874] in_atomic(): 1, irqs_disabled(): 0, pid: 84, name: udevd [ 13.351218] 1 lock held by udevd/84: [ 13.351222] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 13.351234] CPU: 0 PID: 84 Comm: udevd Tainted: G W 3.10.0 #454 [ 13.351238] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 13.351242] ffff88003f402b40 ffff88001b2efb58 ffffffff816c0ac1 ffff88001b2efb78 [ 13.351252] ffffffff81078647 ffff88003f402b40 0000000000000010 ffff88001b2efc08 [ 13.351254] ffffffff8118394f 0000000000000001 0000000000000082 0000000000000000 [ 13.351257] Call Trace: [ 13.351260] [] dump_stack+0x19/0x1b [ 13.351270] [] might_sleep+0xe7/0x110 [ 13.351274] [] kmalloc_node_track_caller+0x6f/0x290 [ 13.351277] [] ? pskb_expand_head+0x6b/0x2e0 [ 13.351280] [] ? mark_held_locks+0x74/0x150 [ 13.351282] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 13.351284] [] pskb_expand_head+0x6b/0x2e0 [ 13.351286] [] netlink_trim+0x7f/0xc0 [ 13.351288] [] netlink_unicast+0x48/0x1e0 [ 13.351292] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 13.351294] [] kipcm_netlink_notify+0x32/0x80 [ 13.351296] [] notifier_call_chain+0x4d/0x70 [ 13.351298] [] atomic_notifier_call_chain+0x82/0xc0 [ 13.351300] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 13.351302] [] atomic_notifier_call_chain+0x16/0x20 [ 13.351304] [] netlink_release+0x282/0x2c0 [ 13.351306] [] sock_release+0x28/0x90 [ 13.351308] [] sock_close+0x12/0x20 [ 13.351310] [] fput+0xd3/0x260 [ 13.351312] [] ? close_fd+0x80/0xb0 [ 13.351315] [] __fput+0xe/0x10 [ 13.351318] [] task_work_run+0xb4/0xe0 [ 13.351321] [] do_notify_resume+0xaa/0xc0 [ 13.351323] [] int_signal+0x12/0x17 [ 13.351351] rina-rnl-utils: Could not send unicast msg: -111 [ 13.351352] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.351590] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.351592] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.351615] rina-rnl-utils: Could not send unicast msg: -111 [ 13.351616] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.354946] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.354948] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.354972] rina-rnl-utils: Could not send unicast msg: -111 [ 13.354973] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.358813] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.358815] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.358839] rina-rnl-utils: Could not send unicast msg: -111 [ 13.358840] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.360030] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.360032] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.360056] rina-rnl-utils: Could not send unicast msg: -111 [ 13.360057] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.363813] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.363815] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.363848] rina-rnl-utils: Could not send unicast msg: -111 [ 13.363849] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.367750] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.367753] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.367778] rina-rnl-utils: Could not send unicast msg: -111 [ 13.367779] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.371542] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.371544] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.371568] rina-rnl-utils: Could not send unicast msg: -111 [ 13.371569] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.375123] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.375125] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.375149] rina-rnl-utils: Could not send unicast msg: -111 [ 13.375150] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.378677] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.378678] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.378702] rina-rnl-utils: Could not send unicast msg: -111 [ 13.378703] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.379853] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.379855] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.379879] rina-rnl-utils: Could not send unicast msg: -111 [ 13.379879] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.383629] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.383631] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.383656] rina-rnl-utils: Could not send unicast msg: -111 [ 13.383657] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.387355] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.387357] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.387381] rina-rnl-utils: Could not send unicast msg: -111 [ 13.387382] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.391015] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.391017] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.391042] rina-rnl-utils: Could not send unicast msg: -111 [ 13.391043] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.394941] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.394943] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.394967] rina-rnl-utils: Could not send unicast msg: -111 [ 13.394968] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.398665] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.398667] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.398693] rina-rnl-utils: Could not send unicast msg: -111 [ 13.398694] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.399905] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.399907] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.399932] rina-rnl-utils: Could not send unicast msg: -111 [ 13.399933] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.403721] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.403723] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.403747] rina-rnl-utils: Could not send unicast msg: -111 [ 13.403748] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.407612] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.407614] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.407638] rina-rnl-utils: Could not send unicast msg: -111 [ 13.407639] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.411994] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.411996] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.412020] rina-rnl-utils: Could not send unicast msg: -111 [ 13.412021] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.415567] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.415569] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.415593] rina-rnl-utils: Could not send unicast msg: -111 [ 13.415594] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.419033] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.419035] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.419059] rina-rnl-utils: Could not send unicast msg: -111 [ 13.419060] rina-rnl: Error notifying IPC Manager in user space, -1 [ 13.426762] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 13.426765] rina-rnl-utils: Result of genlmesg_end: 32 [ 13.426789] rina-rnl-utils: Could not send unicast msg: -111 [ 13.426790] rina-rnl: Error notifying IPC Manager in user space, -1 [ 17.098976] mount (292) used greatest stack depth: 3008 bytes left [ 18.579716] udevd[329]: starting version 175 [ 20.754890] input: PC Speaker as /devices/platform/pcspkr/input/input4 [ 20.806611] piix4_smbus 0000:00:07.0: SMBus base address uninitialized - upgrade BIOS or use force_addr=0xaddr [ 21.622807] input: ImExPS/2 Generic Explorer Mouse as /devices/platform/i8042/serio1/input/input5 [ 21.866570] microcode: CPU0 sig=0x306a9, pf=0x1, revision=0x0 [ 22.890584] microcode: Microcode Update Driver: v2.00 tigran@aivazian.fsnet.co.uk, Peter Oruba [ 23.185117] echo (502) used greatest stack depth: 2960 bytes left [ 26.584003] Adding 392188k swap on /dev/sda5. Priority:-1 extents:1 across:392188k FS [ 26.675503] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.675508] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.675510] BUG: sleeping function called from invalid context at mm/slub.c:926 [ 26.675942] in_atomic(): 1, irqs_disabled(): 0, pid: 428, name: udevd [ 26.676351] 1 lock held by udevd/428: [ 26.676353] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.676366] CPU: 0 PID: 428 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.676367] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.676369] ffff88003f402b40 ffff880036293b58 ffffffff816c0ac1 ffff880036293b78 [ 26.676373] ffffffff81078647 ffff88003f402b40 0000000000000010 ffff880036293c08 [ 26.676375] ffffffff8118394f 0000000000000001 0000000000000082 0000000000000000 [ 26.676378] Call Trace: [ 26.676384] [] dump_stack+0x19/0x1b [ 26.676388] [] might_sleep+0xe7/0x110 [ 26.676393] [] kmalloc_node_track_caller+0x6f/0x290 [ 26.676397] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.676401] [] ? mark_held_locks+0x74/0x150 [ 26.676403] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.676405] [] pskb_expand_head+0x6b/0x2e0 [ 26.676407] [] netlink_trim+0x7f/0xc0 [ 26.676409] [] netlink_unicast+0x48/0x1e0 [ 26.678539] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.678557] [] kipcm_netlink_notify+0x32/0x80 [ 26.678572] [] notifier_call_chain+0x4d/0x70 [ 26.678585] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.678598] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 26.678609] [] atomic_notifier_call_chain+0x16/0x20 [ 26.678620] [] netlink_release+0x282/0x2c0 [ 26.678631] [] sock_release+0x28/0x90 [ 26.678641] [] sock_close+0x12/0x20 [ 26.678654] [] fput+0xd3/0x260 [ 26.678663] [] ? close_fd+0x80/0xb0 [ 26.678672] [] __fput+0xe/0x10 [ 26.678683] [] task_work_run+0xb4/0xe0 [ 26.678692] [] do_notify_resume+0xaa/0xc0 [ 26.678701] [] int_signal+0x12/0x17 [ 26.678708] BUG: scheduling while atomic: udevd/428/0x10000002 [ 26.679067] 1 lock held by udevd/428: [ 26.679071] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.679079] Modules linked in: microcode psmouse i2c_piix4 pcspkr serio_raw hid_generic usbhid hid ahci libahci e1000 [ 26.679099] CPU: 0 PID: 428 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.679100] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.679101] 0000000000000000 ffff880036293aa8 ffffffff816c0ac1 ffff880036293ac8 [ 26.679104] ffffffff816bb822 0000000000000000 ffff88003fbd4000 ffff880036293b48 [ 26.679106] ffffffff816c7475 ffff88003f9fffc0 000000000000000b ffff8800380ca440 [ 26.679108] Call Trace: [ 26.679111] [] dump_stack+0x19/0x1b [ 26.679114] [] __schedule_bug+0x63/0x73 [ 26.679116] [] schedule+0x7e5/0x8a0 [ 26.679119] [] cond_resched+0x2a/0x40 [ 26.679122] [] _cond_resched+0x32/0x40 [ 26.679125] [] __kmalloc_node_track_caller+0x74/0x290 [ 26.679128] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.679130] [] ? mark_held_locks+0x74/0x150 [ 26.679133] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.679135] [] pskb_expand_head+0x6b/0x2e0 [ 26.679137] [] netlink_trim+0x7f/0xc0 [ 26.679138] [] netlink_unicast+0x48/0x1e0 [ 26.679142] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.679145] [] kipcm_netlink_notify+0x32/0x80 [ 26.679147] [] notifier_call_chain+0x4d/0x70 [ 26.679149] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.679151] [] ? __atomic_notifier_call_chain+0x5/0xc0 [ 26.679153] [] atomic_notifier_call_chain+0x16/0x20 [ 26.679155] [] netlink_release+0x282/0x2c0 [ 26.679157] [] sock_release+0x28/0x90 [ 26.679159] [] sock_close+0x12/0x20 [ 26.679161] [] fput+0xd3/0x260 [ 26.679163] [] ? close_fd+0x80/0xb0 [ 26.679165] [] ____fput+0xe/0x10 [ 26.679167] [] task_work_run+0xb4/0xe0 [ 26.679169] [] do_notify_resume+0xaa/0xc0 [ 26.679171] [] int_signal+0x12/0x17 [ 26.683271] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.683275] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.683309] rina-rnl-utils: Could not send unicast msg: -111 [ 26.683311] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.690959] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.690965] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.690999] rina-rnl-utils: Could not send unicast msg: -111 [ 26.691000] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.705807] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.705813] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.706001] rina-rnl-utils: Could not send unicast msg: -111 [ 26.706009] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.715607] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.715612] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.715645] rina-rnl-utils: Could not send unicast msg: -111 [ 26.715646] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.722903] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.722907] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.722938] rina-rnl-utils: Could not send unicast msg: -111 [ 26.722939] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.731612] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.731618] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.731647] rina-rnl-utils: Could not send unicast msg: -111 [ 26.731649] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.738655] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.738660] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.738689] rina-rnl-utils: Could not send unicast msg: -111 [ 26.738690] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.755896] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.755901] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.755931] rina-rnl-utils: Could not send unicast msg: -111 [ 26.755932] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.777913] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.777917] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.777921] BUG: scheduling while atomic: udevd/389/0x10000002 [ 26.778687] 1 lock held by udevd/389: [ 26.778689] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.778700] Modules linked in: microcode psmouse i2c_piix4 pcspkr serio_raw hid_generic usbhid hid ahci libahci e1000 [ 26.778715] CPU: 0 PID: 389 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.778717] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.778718] 0000000000000000 ffff88001aa89aa8 ffffffff816c0ac1 ffff88001aa89ac8 [ 26.778722] ffffffff816bb822 0000000000000000 ffff88003fbd4000 ffff88001aa89b48 [ 26.778726] ffffffff816c7475 ffff88003c23ab50 ffff88003c23a440 ffff88003c23a440 [ 26.778729] Call Trace: [ 26.778735] [] dump_stack+0x19/0x1b [ 26.778741] [] schedule_bug+0x63/0x73 [ 26.778745] [] schedule+0x7e5/0x8a0 [ 26.778763] [] cond_resched+0x2a/0x40 [ 26.778767] [] _cond_resched+0x32/0x40 [ 26.778772] [] kmalloc_node_track_caller+0x74/0x290 [ 26.778776] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.778780] [] ? mark_held_locks+0x74/0x150 [ 26.778782] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.778784] [] pskb_expand_head+0x6b/0x2e0 [ 26.778786] [] netlink_trim+0x7f/0xc0 [ 26.778788] [] netlink_unicast+0x48/0x1e0 [ 26.778792] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.778794] [] kipcm_netlink_notify+0x32/0x80 [ 26.778797] [] notifier_call_chain+0x4d/0x70 [ 26.778799] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.778801] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 26.778803] [] atomic_notifier_call_chain+0x16/0x20 [ 26.778806] [] netlink_release+0x282/0x2c0 [ 26.778810] [] sock_release+0x28/0x90 [ 26.778813] [] sock_close+0x12/0x20 [ 26.778817] [] fput+0xd3/0x260 [ 26.778820] [] ? close_fd+0x80/0xb0 [ 26.778824] [] __fput+0xe/0x10 [ 26.778828] [] task_work_run+0xb4/0xe0 [ 26.778832] [] do_notify_resume+0xaa/0xc0 [ 26.778834] [] int_signal+0x12/0x17 [ 26.779122] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.779125] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.779128] BUG: scheduling while atomic: udevd/401/0x10000002 [ 26.779485] 1 lock held by udevd/401: [ 26.779488] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.779498] Modules linked in: microcode psmouse i2c_piix4 pcspkr serio_raw hid_generic usbhid hid ahci libahci e1000 [ 26.779513] CPU: 0 PID: 401 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.779515] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.779517] 0000000000000000 ffff880027f0faa8 ffffffff816c0ac1 ffff880027f0fac8 [ 26.779521] ffffffff816bb822 0000000000000000 ffff88003fbd4000 ffff880027f0fb48 [ 26.779525] ffffffff816c7475 ffff88003c20cf90 ffff88003c20c880 ffff88003c20c880 [ 26.779529] Call Trace: [ 26.779534] [] dump_stack+0x19/0x1b [ 26.779538] [] __schedule_bug+0x63/0x73 [ 26.779542] [] schedule+0x7e5/0x8a0 [ 26.779547] [] cond_resched+0x2a/0x40 [ 26.779550] [] _cond_resched+0x32/0x40 [ 26.779554] [] __kmalloc_node_track_caller+0x74/0x290 [ 26.779558] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.779562] [] ? mark_held_locks+0x74/0x150 [ 26.779566] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.779568] [] pskb_expand_head+0x6b/0x2e0 [ 26.779572] [] netlink_trim+0x7f/0xc0 [ 26.779574] [] netlink_unicast+0x48/0x1e0 [ 26.779579] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.779582] [] kipcm_netlink_notify+0x32/0x80 [ 26.779585] [] notifier_call_chain+0x4d/0x70 [ 26.779588] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.779591] [] ? __atomic_notifier_call_chain+0x5/0xc0 [ 26.779595] [] atomic_notifier_call_chain+0x16/0x20 [ 26.779597] [] netlink_release+0x282/0x2c0 [ 26.779601] [] sock_release+0x28/0x90 [ 26.779604] [] sock_close+0x12/0x20 [ 26.779608] [] fput+0xd3/0x260 [ 26.779611] [] ? close_fd+0x80/0xb0 [ 26.779615] [] ____fput+0xe/0x10 [ 26.779619] [] task_work_run+0xb4/0xe0 [ 26.779624] [] do_notify_resume+0xaa/0xc0 [ 26.779627] [] int_signal+0x12/0x17 [ 26.780082] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.780088] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.780095] BUG: scheduling while atomic: udevd/402/0x10000002 [ 26.780220] 1 lock held by udevd/402: [ 26.780220] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.780220] Modules linked in: microcode psmouse i2c_piix4 pcspkr serio_raw hid_generic usbhid hid ahci libahci e1000 [ 26.780220] CPU: 0 PID: 402 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.780220] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.780220] 0000000000000000 ffff880038c09aa8 ffffffff816c0ac1 ffff880038c09ac8 [ 26.780220] ffffffff816bb822 0000000000000000 ffff88003fbd4000 ffff880038c09b48 [ 26.780220] ffffffff816c7475 ffff88003c270710 ffff88003c270000 ffff88003c270000 [ 26.780220] Call Trace: [ 26.780220] [] dump_stack+0x19/0x1b [ 26.780220] [] schedule_bug+0x63/0x73 [ 26.780220] [] schedule+0x7e5/0x8a0 [ 26.780220] [] cond_resched+0x2a/0x40 [ 26.780220] [] _cond_resched+0x32/0x40 [ 26.780220] [] kmalloc_node_track_caller+0x74/0x290 [ 26.780220] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.780220] [] ? mark_held_locks+0x74/0x150 [ 26.780220] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.780220] [] pskb_expand_head+0x6b/0x2e0 [ 26.780220] [] netlink_trim+0x7f/0xc0 [ 26.780220] [] netlink_unicast+0x48/0x1e0 [ 26.780220] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.780220] [] kipcm_netlink_notify+0x32/0x80 [ 26.780220] [] notifier_call_chain+0x4d/0x70 [ 26.780220] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.780220] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 26.780220] [] atomic_notifier_call_chain+0x16/0x20 [ 26.780220] [] netlink_release+0x282/0x2c0 [ 26.780220] [] sock_release+0x28/0x90 [ 26.780220] [] sock_close+0x12/0x20 [ 26.780220] [] fput+0xd3/0x260 [ 26.780220] [] ? close_fd+0x80/0xb0 [ 26.780220] [] __fput+0xe/0x10 [ 26.780220] [] task_work_run+0xb4/0xe0 [ 26.780220] [] do_notify_resume+0xaa/0xc0 [ 26.780220] [] int_signal+0x12/0x17 [ 26.787123] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.787129] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.787133] BUG: scheduling while atomic: udevd/406/0x10000002 [ 26.787428] 1 lock held by udevd/406: [ 26.787430] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.787445] Modules linked in: microcode psmouse i2c_piix4 pcspkr serio_raw hid_generic usbhid hid ahci libahci e1000 [ 26.787461] CPU: 0 PID: 406 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.787463] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.787465] 0000000000000000 ffff880038045aa8 ffffffff816c0ac1 ffff880038045ac8 [ 26.787469] ffffffff816bb822 0000000000000000 ffff88003fbd4000 ffff880038045b48 [ 26.787473] ffffffff816c7475 ffff88001b1b8710 ffff88001b1b8000 ffff88001b1b8000 [ 26.787476] Call Trace: [ 26.787483] [] dump_stack+0x19/0x1b [ 26.787489] [] __schedule_bug+0x63/0x73 [ 26.787492] [] schedule+0x7e5/0x8a0 [ 26.787498] [] cond_resched+0x2a/0x40 [ 26.787501] [] _cond_resched+0x32/0x40 [ 26.787509] [] __kmalloc_node_track_caller+0x74/0x290 [ 26.787514] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.787519] [] ? mark_held_locks+0x74/0x150 [ 26.787521] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.787523] [] pskb_expand_head+0x6b/0x2e0 [ 26.787526] [] netlink_trim+0x7f/0xc0 [ 26.787529] [] netlink_unicast+0x48/0x1e0 [ 26.787536] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.787539] [] kipcm_netlink_notify+0x32/0x80 [ 26.787541] [] notifier_call_chain+0x4d/0x70 [ 26.787543] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.787546] [] ? __atomic_notifier_call_chain+0x5/0xc0 [ 26.787548] [] atomic_notifier_call_chain+0x16/0x20 [ 26.787550] [] netlink_release+0x282/0x2c0 [ 26.787554] [] sock_release+0x28/0x90 [ 26.787556] [] sock_close+0x12/0x20 [ 26.787565] [] fput+0xd3/0x260 [ 26.787568] [] ? close_fd+0x80/0xb0 [ 26.787570] [] ____fput+0xe/0x10 [ 26.787575] [] task_work_run+0xb4/0xe0 [ 26.787581] [] do_notify_resume+0xaa/0xc0 [ 26.787584] [] int_signal+0x12/0x17 [ 26.788029] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.788031] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.788033] BUG: scheduling while atomic: udevd/422/0x10000002 [ 26.790684] 1 lock held by udevd/422: [ 26.790686] #3: (rcu_read_lock){.+.+.+}, at: [] atomic_notifier_call_chain+0x5/0xc0 [ 26.790694] Modules linked in: microcode psmouse i2c_piix4 pcspkr serio_raw hid_generic usbhid hid ahci libahci e1000 [ 26.790706] CPU: 0 PID: 422 Comm: udevd Tainted: G W 3.10.0 #454 [ 26.790707] Hardware name: innotek GmbH VirtualBox/VirtualBox, BIOS VirtualBox 12/01/2006 [ 26.790717] 0000000000000000 ffff88001b199aa8 ffffffff816c0ac1 ffff88001b199ac8 [ 26.790720] ffffffff816bb822 0000000000000000 ffff88003fbd4000 ffff88001b199b48 [ 26.790722] ffffffff816c7475 ffff88003c272b50 ffff88003c272440 ffff88003c272440 [ 26.790724] Call Trace: [ 26.790729] [] dump_stack+0x19/0x1b [ 26.790732] [] schedule_bug+0x63/0x73 [ 26.790735] [] schedule+0x7e5/0x8a0 [ 26.790738] [] cond_resched+0x2a/0x40 [ 26.790741] [] _cond_resched+0x32/0x40 [ 26.790745] [] kmalloc_node_track_caller+0x74/0x290 [ 26.790748] [] ? pskb_expand_head+0x6b/0x2e0 [ 26.790751] [] ? mark_held_locks+0x74/0x150 [ 26.790754] [] kmalloc_reserve.isra.51+0x3c/0xa0 [ 26.790756] [] pskb_expand_head+0x6b/0x2e0 [ 26.790758] [] netlink_trim+0x7f/0xc0 [ 26.790760] [] netlink_unicast+0x48/0x1e0 [ 26.790764] [] rnl_ipcm_sock_closed_notif_msg+0xbe/0x140 [ 26.790766] [] kipcm_netlink_notify+0x32/0x80 [ 26.790768] [] notifier_call_chain+0x4d/0x70 [ 26.790777] [] atomic_notifier_call_chain+0x82/0xc0 [ 26.790779] [] ? atomic_notifier_call_chain+0x5/0xc0 [ 26.790781] [] atomic_notifier_call_chain+0x16/0x20 [ 26.790783] [] netlink_release+0x282/0x2c0 [ 26.790786] [] sock_release+0x28/0x90 [ 26.790788] [] sock_close+0x12/0x20 [ 26.790791] [] fput+0xd3/0x260 [ 26.790794] [] ? close_fd+0x80/0xb0 [ 26.790796] [] __fput+0xe/0x10 [ 26.790801] [] task_work_run+0xb4/0xe0 [ 26.790804] [] do_notify_resume+0xaa/0xc0 [ 26.790807] [] int_signal+0x12/0x17 [ 26.811080] rina-rnl-utils: Could not send unicast msg: -111 [ 26.811084] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.814353] rina-rnl-utils: Could not send unicast msg: -111 [ 26.814355] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.822779] rina-rnl-utils: Could not send unicast msg: -111 [ 26.822783] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.835874] rina-rnl-utils: Could not send unicast msg: -111 [ 26.835880] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.842667] rina-rnl-utils: Could not send unicast msg: -111 [ 26.842670] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.850906] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.850911] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.850942] rina-rnl-utils: Could not send unicast msg: -111 [ 26.850943] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.882789] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.882793] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.882830] rina-rnl-utils: Could not send unicast msg: -111 [ 26.882831] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.898676] rina-rnl-utils: Could not send unicast msg: -111 [ 26.898686] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.971017] rina-rnl-utils: Entring rnl_format_generic_u32_param_msg... [ 26.971028] rina-rnl-utils: Result of genlmesg_end: 32 [ 26.971060] rina-rnl-utils: Could not send unicast msg: -111 [ 26.971061] rina-rnl: Error notifying IPC Manager in user space, -1 [ 26.982511] rina-rnl-utils: Entring rnl_format_generic_u32_parammsg... [ 26.982515] rina-rnl-utils: Result of genlmesg

kewinrausch commented 9 years ago

Comment by edugrasa Friday Oct 04, 2013 at 12:28 GMT


Francesco, is there a work queue example I can take a look at to finally fix this issue?