[<prev] [next>] [<thread-prev] [thread-next>] [day] [month] [year] [list]
Message-ID: <alpine.LRH.2.11.1507172204220.13702@math.ut.ee>
Date: Fri, 17 Jul 2015 22:07:34 +0300 (EEST)
From: mroos@...ux.ee
To: Thomas Graf <tgraf@...g.ch>
cc: davem@...emloft.net, netdev@...r.kernel.org,
herbert@...dor.apana.org.au, eric.dumazet@...il.com
Subject: Re: [PATCH net-next v2] rhashtable: Allow other tasks to be scheduled
in large lookup loops
> Depending on system speed, the large lookup/insert/delete loops of the testsuite can
> take a considerable amount of time to complete causing watchdog warnings to appear.
> Allow other tasks to be scheduled throughout the loops.
>
> Reported-by: Meelis Roos <mroos@...ux.ee>
> Signed-off-by: Thomas Graf <tgraf@...g.ch>
> ---
> v2: Use cond_resched() instead schedule()
Tested it. The warning is gone from rhashtable test but now it is
present in rbtree test (it was not there before). Same kernel, just your
patch applied - but it should not change rbtree test???
[ 0.000000] PROMLIB: Sun IEEE Boot Prom 'OBP 3.31.0 2001/07/25 20:36'
[ 0.000000] PROMLIB: Root node compatible:
[ 0.000000] Linux version 4.2.0-rc2-00077-gf760b87-dirty (mroos@u5) (gcc version 4.9.3 (Debian 4.9.3-1) ) #21 Fri Jul 17 20:15:21 EEST 2015
[ 0.000000] bootconsole [earlyprom0] enabled
[ 0.000000] ARCH: SUN4U
[ 0.000000] Ethernet address: 08:00:20:f8:c7:72
[ 0.000000] MM: PAGE_OFFSET is 0xfffff80000000000 (max_phys_bits == 40)
[ 0.000000] MM: VMALLOC [0x0000000100000000 --> 0x0000060000000000]
[ 0.000000] MM: VMEMMAP [0x0000060000000000 --> 0x00000c0000000000]
[ 0.000000] Kernel: Using 10 locked TLB entries for main kernel image.
[ 0.000000] Remapping the kernel... done.
[ 0.000000] kmemleak: Kernel memory leak detector disabled
[ 0.000000] OF stdout device is: /pci@1f,0/pci@1,1/ebus@...e@14,400000:a
[ 0.000000] PROM: Built device tree with 70266 bytes of memory.
[ 0.000000] Top of RAM: 0x1ff2c000, Total RAM: 0x1ff2a000
[ 0.000000] Memory hole size: 0MB
[ 0.000000] Allocated 16384 bytes for kernel page tables.
[ 0.000000] Zone ranges:
[ 0.000000] Normal [mem 0x0000000000000000-0x000000001ff2bfff]
[ 0.000000] Movable zone start for each node
[ 0.000000] Early memory node ranges
[ 0.000000] node 0: [mem 0x0000000000000000-0x000000001fefdfff]
[ 0.000000] node 0: [mem 0x000000001ff00000-0x000000001ff2bfff]
[ 0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x000000001ff2bfff]
[ 0.000000] On node 0 totalpages: 65429
[ 0.000000] Normal zone: 512 pages used for memmap
[ 0.000000] Normal zone: 0 pages reserved
[ 0.000000] Normal zone: 65429 pages, LIFO batch:15
[ 0.000000] Booting Linux...
[ 0.000000] CPU CAPS: [flush,stbar,swap,muldiv,v9,mul32,div32,v8plus]
[ 0.000000] CPU CAPS: [vis]
[ 0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[ 0.000000] pcpu-alloc: [0] 0
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 64917
[ 0.000000] Kernel command line: root=/dev/sda1 ro
[ 0.000000] PID hash table entries: 2048 (order: 1, 16384 bytes)
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 524288 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 262144 bytes)
[ 0.000000] Sorting __ex_table...
[ 0.000000] Memory: 475912K/523432K available (5270K kernel code, 516K rwdata, 1672K rodata, 520K init, 30210K bss, 47520K reserved, 0K cma-reserved)
[ 0.000000] Running RCU self tests
[ 0.000000] Testing tracer nop: PASSED
[ 0.000000] NR_IRQS:2048 nr_irqs:2048 1
[ 26.882478] clocksource: tick: mask: 0xffffffffffffffff max_cycles: 0x5306eb473f, max_idle_ns: 440795213232 ns
[ 26.986192] clocksource: mult[2c71c72] shift[24]
[ 27.025729] clockevent: mult[5c28f5c3] shift[32]
[ 27.067997] Console: colour dummy device 80x25
[ 27.104149] console [tty0] enabled
[ 27.128868] bootconsole [earlyprom0] disabled
[ 27.165340] Lock dependency validator: Copyright (c) 2006 Red Hat, Inc., Ingo Molnar
[ 27.165405] ... MAX_LOCKDEP_SUBCLASSES: 8
[ 27.165445] ... MAX_LOCK_DEPTH: 48
[ 27.165486] ... MAX_LOCKDEP_KEYS: 8191
[ 27.165529] ... CLASSHASH_SIZE: 4096
[ 27.165574] ... MAX_LOCKDEP_ENTRIES: 32768
[ 27.165617] ... MAX_LOCKDEP_CHAINS: 65536
[ 27.165662] ... CHAINHASH_SIZE: 32768
[ 27.165706] memory used by lock dependency info: 8159 kB
[ 27.165756] per task-struct memory footprint: 1920 bytes
[ 27.165802] ------------------------
[ 27.165838] | Locking API testsuite:
[ 27.165873] ----------------------------------------------------------------------------
[ 27.165932] | spin |wlock |rlock |mutex | wsem | rsem |
[ 27.165993] --------------------------------------------------------------------------
[ 27.166092] A-A deadlock: ok | ok | ok | ok | ok | ok |
[ 27.232682] A-B-B-A deadlock: ok | ok | ok | ok | ok | ok |
[ 27.299789] A-B-B-C-C-A deadlock: ok | ok | ok | ok | ok | ok |
[ 27.367295] A-B-C-A-B-C deadlock: ok | ok | ok | ok | ok | ok |
[ 27.434877] A-B-B-C-C-D-D-A deadlock: ok | ok | ok | ok | ok | ok |
[ 27.502857] A-B-C-D-B-D-D-A deadlock: ok | ok | ok | ok | ok | ok |
[ 27.570913] A-B-C-D-B-C-D-A deadlock: ok | ok | ok | ok | ok | ok |
[ 27.639030] double unlock: ok | ok | ok | ok | ok | ok |
[ 27.706053] initialize held: ok | ok | ok | ok | ok | ok |
[ 27.772899] bad unlock order: ok | ok | ok | ok | ok | ok |
[ 27.840393] --------------------------------------------------------------------------
[ 27.840491] recursive read-lock: | ok | | ok |
[ 27.862994] recursive read-lock #2: | ok | | ok |
[ 27.885492] mixed read-write-lock: | ok | | ok |
[ 27.908000] mixed write-read-lock: | ok | | ok |
[ 27.930496] --------------------------------------------------------------------------
[ 27.930594] hard-irqs-on + irq-safe-A/12: ok | ok | ok |
[ 27.964173] soft-irqs-on + irq-safe-A/12: ok | ok | ok |
[ 27.997791] hard-irqs-on + irq-safe-A/21: ok | ok | ok |
[ 28.031406] soft-irqs-on + irq-safe-A/21: ok | ok | ok |
[ 28.065035] sirq-safe-A => hirqs-on/12: ok | ok | ok |
[ 28.098675] sirq-safe-A => hirqs-on/21: ok | ok | ok |
[ 28.132309] hard-safe-A + irqs-on/12: ok | ok | ok |
[ 28.165911] soft-safe-A + irqs-on/12: ok | ok | ok |
[ 28.199528] hard-safe-A + irqs-on/21: ok | ok | ok |
[ 28.233145] soft-safe-A + irqs-on/21: ok | ok | ok |
[ 28.266773] hard-safe-A + unsafe-B #1/123: ok | ok | ok |
[ 28.300558] soft-safe-A + unsafe-B #1/123: ok | ok | ok |
[ 28.334375] hard-safe-A + unsafe-B #1/132: ok | ok | ok |
[ 28.368163] soft-safe-A + unsafe-B #1/132: ok | ok | ok |
[ 28.401968] hard-safe-A + unsafe-B #1/213: ok | ok | ok |
[ 28.435786] soft-safe-A + unsafe-B #1/213: ok | ok | ok |
[ 28.469610] hard-safe-A + unsafe-B #1/231: ok | ok | ok |
[ 28.503385] soft-safe-A + unsafe-B #1/231: ok | ok | ok |
[ 28.537166] hard-safe-A + unsafe-B #1/312: ok | ok | ok |
[ 28.570842] soft-safe-A + unsafe-B #1/312: ok | ok | ok |
[ 28.604517] hard-safe-A + unsafe-B #1/321: ok | ok | ok |
[ 28.638286] soft-safe-A + unsafe-B #1/321: ok | ok | ok |
[ 28.672064] hard-safe-A + unsafe-B #2/123: ok | ok | ok |
[ 28.705863] soft-safe-A + unsafe-B #2/123: ok | ok | ok |
[ 28.739714] hard-safe-A + unsafe-B #2/132: ok | ok | ok |
[ 28.773532] soft-safe-A + unsafe-B #2/132: ok | ok | ok |
[ 28.807368] hard-safe-A + unsafe-B #2/213: ok | ok | ok |
[ 28.841217] soft-safe-A + unsafe-B #2/213: ok | ok | ok |
[ 28.875100] hard-safe-A + unsafe-B #2/231: ok | ok | ok |
[ 28.908929] soft-safe-A + unsafe-B #2/231: ok | ok | ok |
[ 28.942758] hard-safe-A + unsafe-B #2/312: ok | ok | ok |
[ 28.976574] soft-safe-A + unsafe-B #2/312: ok | ok | ok |
[ 29.010499] hard-safe-A + unsafe-B #2/321: ok | ok | ok |
[ 29.044316] soft-safe-A + unsafe-B #2/321: ok | ok | ok |
[ 29.078152] hard-irq lock-inversion/123: ok | ok | ok |
[ 29.112000] soft-irq lock-inversion/123: ok | ok | ok |
[ 29.145894] hard-irq lock-inversion/132: ok | ok | ok |
[ 29.179746] soft-irq lock-inversion/132: ok | ok | ok |
[ 29.213631] hard-irq lock-inversion/213: ok | ok | ok |
[ 29.247510] soft-irq lock-inversion/213: ok | ok | ok |
[ 29.281418] hard-irq lock-inversion/231: ok | ok | ok |
[ 29.315262] soft-irq lock-inversion/231: ok | ok | ok |
[ 29.349134] hard-irq lock-inversion/312: ok | ok | ok |
[ 29.382994] soft-irq lock-inversion/312: ok | ok | ok |
[ 29.416906] hard-irq lock-inversion/321: ok | ok | ok |
[ 29.450756] soft-irq lock-inversion/321: ok | ok | ok |
[ 29.484624] hard-irq read-recursion/123: ok |
[ 29.495986] soft-irq read-recursion/123: ok |
[ 29.507378] hard-irq read-recursion/132: ok |
[ 29.518743] soft-irq read-recursion/132: ok |
[ 29.530133] hard-irq read-recursion/213: ok |
[ 29.541494] soft-irq read-recursion/213: ok |
[ 29.552870] hard-irq read-recursion/231: ok |
[ 29.564247] soft-irq read-recursion/231: ok |
[ 29.575630] hard-irq read-recursion/312: ok |
[ 29.587004] soft-irq read-recursion/312: ok |
[ 29.598397] hard-irq read-recursion/321: ok |
[ 29.609776] soft-irq read-recursion/321: ok |
[ 29.621160] --------------------------------------------------------------------------
[ 29.621249] | Wound/wait tests |
[ 29.621306] ---------------------
[ 29.621371] ww api failures: ok | ok | ok |
[ 29.655302] ww contexts mixing: ok | ok |
[ 29.677841] finishing ww context: ok | ok | ok | ok |
[ 29.722821] locking mismatches: ok | ok | ok |
[ 29.756630] EDEADLK handling: ok | ok | ok | ok | ok | ok | ok | ok | ok | ok |
[ 29.869817] spinlock nest unlocked: ok |
[ 29.881116] -----------------------------------------------------
[ 29.881193] |block | try |context|
[ 29.881267] -----------------------------------------------------
[ 29.881346] context: ok | ok | ok |
[ 29.915341] try: ok | ok | ok |
[ 29.949163] block: ok | ok | ok |
[ 29.982955] spinlock: ok | ok | ok |
[ 30.017142] -------------------------------------------------------
[ 30.017239] Good, all 253 testcases passed! |
[ 30.017306] ---------------------------------
[ 30.026148] ODEBUG: selftest passed
[ 30.026520] kmemleak: Early log buffer exceeded (2042), please increase DEBUG_KMEMLEAK_EARLY_LOG_SIZE
[ 30.167716] Calibrating delay using timer specific routine.. 727.30 BogoMIPS (lpj=3636502)
[ 30.167862] pid_max: default: 32768 minimum: 301
[ 30.169425] Mount-cache hash table entries: 1024 (order: 0, 8192 bytes)
[ 30.169565] Mountpoint-cache hash table entries: 1024 (order: 0, 8192 bytes)
[ 30.177641] ftrace: allocating 15171 entries in 30 pages
[ 30.257853] devtmpfs: initialized
[ 30.301402] Performance events: No support for PMU type 'ultra12'
[ 30.305277] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 30.308770] Testing tracer function:
[ 30.311509] kworker/u2:0 (11) used greatest stack depth: 8168 bytes left
[ 30.468249] PASSED
[ 30.468339] Testing dynamic ftrace: PASSED
[ 30.748319] Testing dynamic ftrace ops #1: (1 0 1 0 0) (1 1 2 0 0) (2 1 3 0 73) (2 2 4 0 161) PASSED
[ 31.038108] Testing dynamic ftrace ops #2: (1 0 1 77 0) (1 1 2 165 0) (2 1 3 1 3) (2 2 4 86 88) PASSED
[ 31.335881] Testing ftrace recursion: PASSED
[ 31.402866] Testing ftrace recursion safe: PASSED
[ 31.470396] Testing ftrace regs(no arch support): PASSED
[ 31.537829] Testing tracer irqsoff: PASSED
[ 31.563853] Testing tracer function_graph: PASSED
[ 31.733617] atomic64_test: passed
[ 31.739606] NET: Registered protocol family 16
[ 31.812981] /pci@1f,0: PCI IO[1fe02000000] MEM[1ff00000000]
[ 31.813239] /pci@1f,0: SABRE PCI Bus Module ver[0:0]
[ 31.813337] PCI: Scanning PBM /pci@1f,0
[ 31.816979] sabre f005f9c0: PCI host bridge to bus 0000:00
[ 31.817127] pci_bus 0000:00: root bus resource [io 0x1fe02000000-0x1fe02ffffff] (bus address [0x0000-0xffffff])
[ 31.817291] pci_bus 0000:00: root bus resource [mem 0x1ff00000000-0x1ffffffffff] (bus address [0x00000000-0xffffffff])
[ 31.817466] pci_bus 0000:00: root bus resource [bus 00-02]
[ 31.843473] pci 0000:00:01.0: can't claim BAR 8 [mem 0x1ff00000000-0x1ffbfffffff]: address conflict with Video RAM area [??? 0x1ff000a0000-0x1ff000bffff flags 0x80000000]
[ 31.921366] kworker/u2:1 (20) used greatest stack depth: 7896 bytes left
[ 32.212004] vgaarb: device added: PCI:0000:01:02.0,decodes=io+mem,owns=none,locks=none
[ 32.212179] vgaarb: loaded
[ 32.212240] vgaarb: bridge control possible 0000:01:02.0
[ 32.215255] SCSI subsystem initialized
[ 32.227747] libata version 3.00 loaded.
[ 32.241232] /pci@1f,0/pci@1,1/ebus@...eprom@14,0: Mostek regs at 0x1fff1000000
[ 32.446414] DMA-API: preallocated 32768 debug entries
[ 32.446532] DMA-API: debugging enabled by kernel config
[ 32.447868] AUXIO: Found device at /pci@1f,0/pci@1,1/ebus@...uxio@14,726000
[ 32.449072] clocksource: Switched to clocksource tick
[ 33.122262] NET: Registered protocol family 2
[ 33.128387] TCP established hash table entries: 4096 (order: 2, 32768 bytes)
[ 33.128769] TCP bind hash table entries: 4096 (order: 5, 262144 bytes)
[ 33.132231] TCP: Hash tables configured (established 4096 bind 4096)
[ 33.133737] UDP hash table entries: 256 (order: 2, 40960 bytes)
[ 33.134394] UDP-Lite hash table entries: 256 (order: 2, 40960 bytes)
[ 33.137508] NET: Registered protocol family 1
[ 33.138194] PCI: CLS 64 bytes, default 64
[ 33.140569] power: Control reg at 1fff1724000
[ 33.164530] futex hash table entries: 256 (order: 1, 20480 bytes)
[ 33.165052] Initialise system trusted keyring
[ 33.166138] ====[ backtrace testing ]===========
[ 33.166211] Testing a backtrace from process context.
[ 33.166275] The following trace is a kernel self test and not a bug!
[ 33.166367] CPU: 0 PID: 1 Comm: swapper Not tainted 4.2.0-rc2-00077-gf760b87-dirty #21
[ 33.166453] Call Trace:
[ 33.166534] [00000000004d2870] backtrace_regression_test+0x30/0x100
[ 33.166640] [0000000000426e2c] do_one_initcall+0xec/0x1e0
[ 33.166743] [0000000000b58b60] kernel_init_freeable+0x114/0x1c4
[ 33.166859] [000000000091c1ec] kernel_init+0xc/0x100
[ 33.166968] [0000000000405fe4] ret_from_fork+0x1c/0x2c
[ 33.167053] [0000000000000000] (null)
[ 33.167124] Testing a backtrace from irq context.
[ 33.167186] The following trace is a kernel self test and not a bug!
[ 33.169165] CPU: 0 PID: 10 Comm: kworker/u2:1 Not tainted 4.2.0-rc2-00077-gf760b87-dirty #21
[ 33.169307] Workqueue: khelper __call_usermodehelper
[ 33.169399] Call Trace:
[ 33.169494] [00000000004d280c] backtrace_test_irq_callback+0xc/0x40
[ 33.169602] [0000000000460118] tasklet_action+0x78/0xe0
[ 33.169697] [000000000045f378] __do_softirq+0x278/0x680
[ 33.169802] [000000000042be28] do_softirq_own_stack+0x28/0x40
[ 33.169900] [000000000045fa6c] irq_exit+0x4c/0xc0
[ 33.170007] [0000000000929910] timer_interrupt+0x70/0xa0
[ 33.170104] [0000000000426b34] sys_call_table+0x5b8/0x744
[ 33.170206] [00000000006f352c] clear_page_common+0x54/0x80
[ 33.170310] [000000000052bca8] __alloc_pages_nodemask+0x148/0xa60
[ 33.170410] [000000000052c8fc] alloc_kmem_pages_node+0x1c/0x40
[ 33.170511] [0000000000458cd4] copy_process.isra.47+0xf4/0x1580
[ 33.170608] [000000000045a28c] _do_fork+0x6c/0x7c0
[ 33.170699] [000000000045aa48] kernel_thread+0x28/0x40
[ 33.170799] [000000000047171c] __call_usermodehelper+0x3c/0x80
[ 33.170899] [000000000047639c] process_one_work+0x3dc/0x800
[ 33.170995] [0000000000476ad0] worker_thread+0x310/0x500
[ 33.186175] Testing a saved backtrace.
[ 33.186268] The following trace is a kernel self test and not a bug!
[ 33.186346] [<00000000004d290c>] backtrace_regression_test+0xcc/0x100
[ 33.186497] [<0000000000426e2c>] do_one_initcall+0xec/0x1e0
[ 33.186614] [<0000000000b58b60>] kernel_init_freeable+0x114/0x1c4
[ 33.186736] [<000000000091c1ec>] kernel_init+0xc/0x100
[ 33.186855] [<0000000000405fe4>] ret_from_fork+0x1c/0x2c
[ 33.186974] [< (null)>] (null)
[ 33.187061] ====[ end of backtrace testing ]====
[ 33.187292] audit: initializing netlink subsys (disabled)
[ 33.188439] audit: type=2000 audit(5.630:1): initialized
[ 33.203418] HugeTLB registered 8 MB page size, pre-allocated 0 pages
[ 33.216884] Key type big_key registered
[ 33.253244] io scheduler noop registered
[ 33.253690] io scheduler cfq registered (default)
[ 33.253830] start plist test
[ 33.277753] end plist test
[ 33.277825] test_string_helpers: Running tests...
[ 33.284353] Running rhashtable test nelem=8, max_size=65536, shrinking=0
[ 33.284453] Test 00:
[ 33.393788] Adding 50000 keys
[ 35.520471] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 36.463930] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 36.464060] Deleting 50000 keys
[ 37.299798] Duration of test: 3906469241 ns
[ 37.301050] Test 01:
[ 37.410517] Adding 50000 keys
[ 39.539627] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 40.483583] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 40.483714] Deleting 50000 keys
[ 41.318696] Duration of test: 3908637840 ns
[ 41.319906] Test 02:
[ 41.429373] Adding 50000 keys
[ 43.555317] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 44.498058] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 44.498188] Deleting 50000 keys
[ 45.332522] Duration of test: 3903606299 ns
[ 45.333733] Test 03:
[ 45.443216] Adding 50000 keys
[ 47.569233] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 48.511179] Traversal complete: counted=50000, nelems=50000, entries=50000, table-jumps=0
[ 48.511309] Deleting 50000 keys
[ 49.346186] Duration of test: 3903425713 ns
[ 49.347555] Average test time: 3905534773
[ 49.348144] rbtree testing -> 74807 cycles
[ 70.333187] NMI watchdog: BUG: soft lockup - CPU#0 stuck for 22s! [swapper:1]
[ 70.333401] Modules linked in:
[ 70.333499] irq event stamp: 2018938
[ 70.333584] hardirqs last enabled at (2018937): [<0000000000404b1c>] rtrap_xcall+0x18/0x20
[ 70.333770] hardirqs last disabled at (2018938): [<0000000000426b28>] sys_call_table+0x5ac/0x744
[ 70.333967] softirqs last enabled at (2018936): [<000000000045f5fc>] __do_softirq+0x4fc/0x680
[ 70.334168] softirqs last disabled at (2018929): [<000000000042be28>] do_softirq_own_stack+0x28/0x40
[ 70.334394] CPU: 0 PID: 1 Comm: swapper Not tainted 4.2.0-rc2-00077-gf760b87-dirty #21
[ 70.334499] task: fffff8001f09ef60 ti: fffff8001f0fc000 task.ti: fffff8001f0fc000
[ 70.334626] TSTATE: 0000009980001607 TPC: 00000000006e7a3c TNPC: 00000000006e7a40 Y: 00000000 Not tainted
[ 70.334811] TPC: <rb_next+0x7c/0xa0>
[ 70.334902] g0: 0000000000426b28 g1: 00000000029273d8 g2: 00000000029273d8 g3: 0000000002927310
[ 70.335056] g4: fffff8001f09ef60 g5: 0000000000000000 g6: fffff8001f0fc000 g7: 0000000002927310
[ 70.335210] o0: 0000000000000001 o1: fffff8001f0fc3f8 o2: 0000000000921a38 o3: 0000000000000000
[ 70.335365] o4: 0000000000000000 o5: 0000000000b1c800 sp: fffff8001f0ff231 ret_pc: 0000000000404b1c
[ 70.335533] RPC: <rtrap_xcall+0x18/0x20>
[ 70.335628] l0: 0000000000001000 l1: 0000000080001606 l2: 0000000000921a34 l3: 0000000000000400
[ 70.335754] l4: 0000000000000000 l5: 0000000000000000 l6: 0000000000000000 l7: 0000000000000008
[ 70.335879] i0: 0000000002927130 i1: 0000000002927420 i2: 000000052604be08 i3: 0000000582c429c9
[ 70.336005] i4: 0000000002926a00 i5: 0000000002926a01 i6: fffff8001f0ff2e1 i7: 0000000000921adc
[ 70.336142] I7: <check+0x130/0x2d8>
[ 70.336214] Call Trace:
[ 70.336301] [0000000000921adc] check+0x130/0x2d8
[ 70.336420] [0000000000b7cf18] rbtree_test_init+0x124/0x264
[ 70.336544] [0000000000426e2c] do_one_initcall+0xec/0x1e0
[ 70.336675] [0000000000b58b60] kernel_init_freeable+0x114/0x1c4
[ 70.336812] [000000000091c1ec] kernel_init+0xc/0x100
[ 70.336939] [0000000000405fe4] ret_from_fork+0x1c/0x2c
[ 70.337045] [0000000000000000] (null)
[ 70.606757] augmented rbtree testing -> 54275 cycles
[ 86.305230] PCI: Enabling device: (0000:01:02.0), cmd 82
[ 86.305404] atyfb: 3D RAGE PRO (Mach64 GP, PQFP, PCI) [0x4750 rev 0x7c]
[ 86.305551] atyfb: 4M SGRAM (1:1), 14.31818 MHz XTAL, 230 MHz PLL, 100 Mhz MCLK, 100 MHz XCLK
[ 86.369992] Console: switching to colour frame buffer device 80x30
[ 86.382675] atyfb: fb0: ATY Mach64 frame buffer device on PCI
[ 86.411787] f0061c64: ttyS0 at MMIO 0x1fff1400000 (irq = 5, base_baud = 115200) is a SAB82532 V3.2
[ 86.420984] Console: ttyS0 (SAB82532)
[ 103.575130] console [ttyS0] enabled
[ 103.615226] f0061c64: ttyS1 at MMIO 0x1fff1400040 (irq = 5, base_baud = 115200) is a SAB82532 V3.2
[ 104.070027] Floppy drive(s): fd0 is 1.44M
[ 104.266698] loop: module loaded
[ 104.350297] scsi host0: pata_cmd64x
[ 104.390818] scsi host1: pata_cmd64x
[ 104.423873] ata1: PATA max MWDMA2 cmd 0x1fe02c00000 ctl 0x1fe02c00008 bmdma 0x1fe02c00020 irq 14
[ 104.520242] ata2: PATA max MWDMA2 cmd 0x1fe02c00010 ctl 0x1fe02c00018 bmdma 0x1fe02c00028 irq 14
[ 104.622786] pata_cmd64x: active 10 recovery 10 setup 3.
[ 104.622908] pata_cmd64x: active 10 recovery 10 setup 3.
[ 104.637447] FDC 0 is a National Semiconductor PC87306
[ 104.688758] mousedev: PS/2 mouse device common for all mice
[ 104.770560] rtc-m48t59 rtc-m48t59.0: rtc core: registered m48t59 as rtc0
[ 104.844445] NET: Registered protocol family 10
[ 104.911225] ata1.00: ATA-6: ST3120026A, 3.06, max UDMA/100
[ 104.964706] ata1.00: 234441648 sectors, multi 0: LBA48
[ 105.014998] pata_cmd64x: active 3 recovery 1 setup 1.
[ 105.015094] pata_cmd64x: active 3 recovery 1 setup 1.
[ 105.042768] NET: Registered protocol family 17
[ 105.088267] ata1.00: configured for MWDMA2
[ 105.130117] scsi 0:0:0:0: Direct-Access ATA ST3120026A 3.06 PQ: 0 ANSI: 5
[ 105.231225] sd 0:0:0:0: [sda] 234441648 512-byte logical blocks: (120 GB/111 GiB)
[ 105.310038] sd 0:0:0:0: [sda] Write Protect is off
[ 105.354869] sd 0:0:0:0: [sda] Mode Sense: 00 3a 00 00
[ 105.355534] sd 0:0:0:0: [sda] Write cache: enabled, read cache: enabled, doesn't support DPO or FUA
[ 105.464628] pata_cmd64x: active 10 recovery 10 setup 3.
[ 105.464706] pata_cmd64x: active 10 recovery 10 setup 3.
[ 105.486362] Loading compiled-in X.509 certificates
[ 105.531723] registered taskstats version 1
[ 105.568193] Running tests on trace events:
[ 105.604489] Testing event sys_exit:
[ 105.631832] ata2.00: ATAPI: CRD-8322B, 1.06, max MWDMA2
[ 105.686562] pata_cmd64x: active 3 recovery 1 setup 1.
[ 105.686657] pata_cmd64x: active 3 recovery 1 setup 1.
[ 105.699521] ata2.00: configured for MWDMA2
[ 105.739853] OK
[ 105.746950] Testing event sys_enter:
[ 105.783288] scsi 1:0:0:0: CD-ROM LG CD-ROM CRD-8322B 1.06 PQ: 0 ANSI: 5
[ 105.874726] sda: sda1 sda2 sda3
[ 105.909065] OK
[ 105.915753] Testing event task_rename:
[ 105.969072] sd 0:0:0:0: [sda] Attached SCSI disk
[ 106.020084] OK
[ 106.026640] Testing event task_newtask: OK
[ 106.085748] Testing event softirq_raise:
[ 106.121495] sr 1:0:0:0: [sr0] scsi3-mmc drive: 32x/32x cd/rw xa/form2 cdda tray
[ 106.200669] cdrom: Uniform CD-ROM driver Revision: 3.20
[ 106.260064] OK
[ 106.266648] Testing event softirq_exit:
[ 106.304243] sr 1:0:0:0: Attached scsi CD-ROM sr0
[ 106.320463] OK
[ 106.326825] Testing event softirq_entry: OK
[ 106.385469] Testing event irq_handler_exit: OK
[ 106.445229] Testing event irq_handler_entry: OK
[ 106.504686] Testing event signal_deliver: OK
[ 106.554947] Testing event signal_generate: OK
[ 106.614542] Testing event workqueue_execute_end: OK
[ 106.674956] Testing event workqueue_execute_start: OK
[ 106.734784] Testing event workqueue_activate_work: OK
[ 106.794474] Testing event workqueue_queue_work: OK
[ 106.854831] Testing event sched_wake_idle_without_ipi: OK
[ 106.924393] Testing event sched_swap_numa: OK
[ 106.974592] Testing event sched_stick_numa: OK
[ 107.034424] Testing event sched_move_numa: OK
[ 107.094169] Testing event sched_process_hang: OK
[ 107.154236] Testing event sched_pi_setprio: OK
[ 107.214197] Testing event sched_stat_runtime: OK
[ 107.274222] Testing event sched_stat_blocked: OK
[ 107.334016] Testing event sched_stat_iowait: OK
[ 107.393735] Testing event sched_stat_sleep: OK
[ 107.454023] Testing event sched_stat_wait: OK
[ 107.503736] Testing event sched_process_exec: OK
[ 107.563682] Testing event sched_process_fork: OK
[ 107.623558] Testing event sched_process_wait: OK
[ 107.683573] Testing event sched_wait_task: OK
[ 107.733430] Testing event sched_process_exit: OK
[ 107.793375] Testing event sched_process_free: OK
[ 107.853310] Testing event sched_migrate_task: OK
[ 107.913307] Testing event sched_switch: OK
[ 107.963075] Testing event sched_wakeup_new: OK
[ 108.013278] Testing event sched_wakeup: OK
[ 108.063318] Testing event sched_kthread_stop_ret: OK
[ 108.123234] Testing event sched_kthread_stop: OK
[ 108.183207] Testing event lock_release: OK
[ 108.234462] Testing event lock_acquire: OK
[ 108.284387] Testing event console: OK
[ 108.333092] Testing event rcu_utilization: OK
[ 108.382889] Testing event tick_stop: OK
[ 108.433211] Testing event itimer_expire: OK
[ 108.483094] Testing event itimer_state: OK
[ 108.533070] Testing event hrtimer_cancel: OK
[ 108.583170] Testing event hrtimer_expire_exit: OK
[ 108.643073] Testing event hrtimer_expire_entry: OK
[ 108.703160] Testing event hrtimer_start: OK
[ 108.753062] Testing event hrtimer_init: OK
[ 108.803047] Testing event timer_cancel: OK
[ 108.853126] Testing event timer_expire_exit: OK
[ 108.913143] Testing event timer_expire_entry: OK
[ 108.973140] Testing event timer_start: OK
[ 109.023135] Testing event timer_init: OK
[ 109.073098] Testing event module_request: OK
[ 109.122808] Testing event module_put: OK
[ 109.173113] Testing event module_get: OK
[ 109.223055] Testing event module_free: OK
[ 109.273029] Testing event module_load: OK
[ 109.323021] Testing event ftrace_test_filter: OK
[ 109.382997] Testing event dev_pm_qos_remove_request: OK
[ 109.442735] Testing event dev_pm_qos_update_request: OK
[ 109.502988] Testing event dev_pm_qos_add_request: OK
[ 109.563219] Testing event pm_qos_update_flags: OK
[ 109.623032] Testing event pm_qos_update_target: OK
[ 109.682991] Testing event pm_qos_update_request_timeout: OK
[ 109.752974] Testing event pm_qos_remove_request: OK
[ 109.812963] Testing event pm_qos_update_request: OK
[ 109.872941] Testing event pm_qos_add_request: OK
[ 109.932932] Testing event power_domain_target: OK
[ 109.993140] Testing event clock_set_rate: OK
[ 110.042762] Testing event clock_disable: OK
[ 110.093046] Testing event clock_enable: OK
[ 110.142937] Testing event wakeup_source_deactivate: OK
[ 110.202757] Testing event wakeup_source_activate: OK
[ 110.263059] Testing event suspend_resume: OK
[ 110.312987] Testing event device_pm_callback_end: OK
[ 110.373106] Testing event device_pm_callback_start: OK
[ 110.433093] Testing event cpu_frequency: OK
[ 110.483002] Testing event pstate_sample: OK
[ 110.532992] Testing event cpu_idle: OK
[ 110.583128] Testing event rpm_return_int: OK
[ 110.633151] Testing event rpm_idle: OK
[ 110.682855] Testing event rpm_resume: OK
[ 110.733126] Testing event rpm_suspend: OK
[ 110.783057] Testing event mm_filemap_add_to_page_cache: OK
[ 110.853114] Testing event mm_filemap_delete_from_page_cache: OK
[ 110.922806] Testing event oom_score_adj_update: OK
[ 110.983137] Testing event mm_lru_activate: OK
[ 111.033367] Testing event mm_lru_insertion: OK
[ 111.092916] Testing event mm_vmscan_lru_shrink_inactive: OK
[ 111.163147] Testing event mm_vmscan_writepage: OK
[ 111.222974] Testing event mm_vmscan_memcg_isolate: OK
[ 111.283267] Testing event mm_vmscan_lru_isolate: OK
[ 111.342928] Testing event mm_shrink_slab_end: OK
[ 111.403224] Testing event mm_shrink_slab_start: OK
[ 111.463306] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK
[ 111.543154] Testing event mm_vmscan_memcg_reclaim_end: OK
[ 111.613139] Testing event mm_vmscan_direct_reclaim_end: OK
[ 111.683139] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK
[ 111.763139] Testing event mm_vmscan_memcg_reclaim_begin: OK
[ 111.832917] Testing event mm_vmscan_direct_reclaim_begin: OK
[ 111.903252] Testing event mm_vmscan_wakeup_kswapd: OK
[ 111.962924] Testing event mm_vmscan_kswapd_wake: OK
[ 112.023234] Testing event mm_vmscan_kswapd_sleep: OK
[ 112.083087] Testing event mm_page_alloc_extfrag: OK
[ 112.143189] Testing event mm_page_pcpu_drain: OK
[ 112.202869] Testing event mm_page_alloc_zone_locked: OK
[ 112.263207] Testing event mm_page_alloc: OK
[ 112.313205] Testing event mm_page_free_batched: OK
[ 112.373147] Testing event mm_page_free: OK
[ 112.422881] Testing event kmem_cache_free: OK
[ 112.473131] Testing event kfree: OK
[ 112.513005] Testing event kmem_cache_alloc_node: OK
[ 112.573023] Testing event kmalloc_node: OK
[ 112.622991] Testing event kmem_cache_alloc: OK
[ 112.682746] Testing event kmalloc: OK
[ 112.733056] Testing event mm_compaction_defer_reset: OK
[ 112.792972] Testing event mm_compaction_defer_compaction: OK
[ 112.862928] Testing event mm_compaction_deferred: OK
[ 112.922937] Testing event mm_compaction_suitable: OK
[ 112.982629] Testing event mm_compaction_finished: OK
[ 113.042882] Testing event mm_compaction_try_to_compact_pages: OK
[ 113.112768] Testing event mm_compaction_end: OK
[ 113.172827] Testing event mm_compaction_begin: OK
[ 113.232762] Testing event mm_compaction_migratepages: OK
[ 113.302834] Testing event mm_compaction_isolate_freepages: OK
[ 113.372389] Testing event mm_compaction_isolate_migratepages: OK
[ 113.442686] Testing event mm_numa_migrate_ratelimit: OK
[ 113.502845] Testing event mm_migrate_pages: OK
[ 113.562432] Testing event writeback_dirty_inode_enqueue: OK
[ 113.632776] Testing event writeback_lazytime_iput: OK
[ 113.692761] Testing event writeback_lazytime: OK
[ 113.752733] Testing event writeback_single_inode: OK
[ 113.812719] Testing event writeback_single_inode_start: OK
[ 113.882483] Testing event writeback_wait_iff_congested: OK
[ 113.952775] Testing event writeback_congestion_wait: OK
[ 114.012454] Testing event writeback_sb_inodes_requeue: OK
[ 114.082742] Testing event balance_dirty_pages: OK
[ 114.142648] Testing event bdi_dirty_ratelimit: OK
[ 114.202426] Testing event global_dirty_state: OK
[ 114.262735] Testing event writeback_queue_io: OK
[ 114.322581] Testing event wbc_writepage: OK
[ 114.372596] Testing event writeback_bdi_register: OK
[ 114.432605] Testing event writeback_wake_background: OK
[ 114.492413] Testing event writeback_nowork: OK
[ 114.552743] Testing event writeback_pages_written: OK
[ 114.612400] Testing event writeback_wait: OK
[ 114.662686] Testing event writeback_written: OK
[ 114.722678] Testing event writeback_start: OK
[ 114.772652] Testing event writeback_exec: OK
[ 114.822600] Testing event writeback_queue: OK
[ 114.872262] Testing event writeback_write_inode: OK
[ 114.932510] Testing event writeback_write_inode_start: OK
[ 115.002442] Testing event writeback_dirty_inode: OK
[ 115.062386] Testing event writeback_dirty_inode_start: OK
[ 115.132132] Testing event writeback_mark_inode_dirty: OK
[ 115.202358] Testing event writeback_dirty_page: OK
[ 115.262358] Testing event time_out_leases: OK
[ 115.312176] Testing event generic_delete_lease: OK
[ 115.372495] Testing event generic_add_lease: OK
[ 115.432366] Testing event break_lease_unblock: OK
[ 115.492363] Testing event break_lease_block: OK
[ 115.552087] Testing event break_lease_noblock: OK
[ 115.612572] Testing event ext4_es_shrink: OK
[ 115.662248] Testing event ext4_insert_range: OK
[ 115.722027] Testing event ext4_collapse_range: OK
[ 115.782316] Testing event ext4_es_shrink_scan_exit: OK
[ 115.842190] Testing event ext4_es_shrink_scan_enter: OK
[ 115.902143] Testing event ext4_es_shrink_count: OK
[ 115.961910] Testing event ext4_es_lookup_extent_exit: OK
[ 116.032014] Testing event ext4_es_lookup_extent_enter: OK
[ 116.102181] Testing event ext4_es_find_delayed_extent_range_exit: OK
[ 116.182225] Testing event ext4_es_find_delayed_extent_range_enter: OK
[ 116.262198] Testing event ext4_es_remove_extent: OK
[ 116.322255] Testing event ext4_es_cache_extent: OK
[ 116.381947] Testing event ext4_es_insert_extent: OK
[ 116.442454] Testing event ext4_ext_remove_space_done: OK
[ 116.512268] Testing event ext4_ext_remove_space: OK
[ 116.572233] Testing event ext4_ext_rm_idx: OK
[ 116.622236] Testing event ext4_ext_rm_leaf: OK
[ 116.682181] Testing event ext4_remove_blocks: OK
[ 116.741946] Testing event ext4_ext_show_extent: OK
[ 116.802124] Testing event ext4_get_reserved_cluster_alloc: OK
[ 116.872121] Testing event ext4_find_delalloc_range: OK
[ 116.932144] Testing event ext4_ext_in_cache: OK
[ 116.991916] Testing event ext4_ext_put_in_cache: OK
[ 117.052338] Testing event ext4_get_implied_cluster_alloc_exit: OK
[ 117.132178] Testing event ext4_ext_handle_unwritten_extents: OK
[ 117.202189] Testing event ext4_trim_all_free: OK
[ 117.262223] Testing event ext4_trim_extent: OK
[ 117.322190] Testing event ext4_journal_start_reserved: OK
[ 117.392286] Testing event ext4_journal_start: OK
[ 117.452392] Testing event ext4_load_inode: OK
[ 117.502284] Testing event ext4_ext_load_extent: OK
[ 117.562264] Testing event ext4_ind_map_blocks_exit: OK
[ 117.622298] Testing event ext4_ext_map_blocks_exit: OK
[ 117.682195] Testing event ext4_ind_map_blocks_enter: OK
[ 117.741884] Testing event ext4_ext_map_blocks_enter: OK
[ 117.802092] Testing event ext4_ext_convert_to_initialized_fastpath: OK
[ 117.882129] Testing event ext4_ext_convert_to_initialized_enter: OK
[ 117.961889] Testing event ext4_truncate_exit: OK
[ 118.022123] Testing event ext4_truncate_enter: OK
[ 118.082106] Testing event ext4_unlink_exit: OK
[ 118.142100] Testing event ext4_unlink_enter: OK
[ 118.201872] Testing event ext4_fallocate_exit: OK
[ 118.262277] Testing event ext4_zero_range: OK
[ 118.311856] Testing event ext4_punch_hole: OK
[ 118.362100] Testing event ext4_fallocate_enter: OK
[ 118.421952] Testing event ext4_direct_IO_exit: OK
[ 118.481921] Testing event ext4_direct_IO_enter: OK
[ 118.541991] Testing event ext4_load_inode_bitmap: OK
[ 118.601830] Testing event ext4_read_block_bitmap_load: OK
[ 118.671570] Testing event ext4_mb_buddy_bitmap_load: OK
[ 118.731846] Testing event ext4_mb_bitmap_load: OK
[ 118.791754] Testing event ext4_da_release_space: OK
[ 118.851514] Testing event ext4_da_reserve_space: OK
[ 118.911795] Testing event ext4_da_update_reserve_space: OK
[ 118.981790] Testing event ext4_forget: OK
[ 119.031797] Testing event ext4_mballoc_free: OK
[ 119.091966] Testing event ext4_mballoc_discard: OK
[ 119.151564] Testing event ext4_mballoc_prealloc: OK
[ 119.211758] Testing event ext4_mballoc_alloc: OK
[ 119.271455] Testing event ext4_alloc_da_blocks: OK
[ 119.331703] Testing event ext4_sync_fs: OK
[ 119.381707] Testing event ext4_sync_file_exit: OK
[ 119.441419] Testing event ext4_sync_file_enter: OK
[ 119.501617] Testing event ext4_free_blocks: OK
[ 119.561500] Testing event ext4_allocate_blocks: OK
[ 119.621627] Testing event ext4_request_blocks: OK
[ 119.681606] Testing event ext4_mb_discard_preallocations: OK
[ 119.751621] Testing event ext4_discard_preallocations: OK
[ 119.821659] Testing event ext4_mb_release_group_pa: OK
[ 119.881454] Testing event ext4_mb_release_inode_pa: OK
[ 119.941614] Testing event ext4_mb_new_group_pa: OK
[ 120.001639] Testing event ext4_mb_new_inode_pa: OK
[ 120.061587] Testing event ext4_discard_blocks: OK
[ 120.121663] Testing event ext4_journalled_invalidatepage: OK
[ 120.191658] Testing event ext4_invalidatepage: OK
[ 120.251674] Testing event ext4_releasepage: OK
[ 120.311235] Testing event ext4_readpage: OK
[ 120.361663] Testing event ext4_writepage: OK
[ 120.411622] Testing event ext4_writepages_result: OK
[ 120.471256] Testing event ext4_da_write_pages_extent: OK
[ 120.541577] Testing event ext4_da_write_pages: OK
[ 120.601555] Testing event ext4_writepages: OK
[ 120.651254] Testing event ext4_da_write_end: OK
[ 120.711563] Testing event ext4_journalled_write_end: OK
[ 120.771566] Testing event ext4_write_end: OK
[ 120.821568] Testing event ext4_da_write_begin: OK
[ 120.881567] Testing event ext4_write_begin: OK
[ 120.941482] Testing event ext4_begin_ordered_truncate: OK
[ 121.011592] Testing event ext4_mark_inode_dirty: OK
[ 121.071597] Testing event ext4_drop_inode: OK
[ 121.121581] Testing event ext4_evict_inode: OK
[ 121.181105] Testing event ext4_allocate_inode: OK
[ 121.241577] Testing event ext4_request_inode: OK
[ 121.301442] Testing event ext4_free_inode: OK
[ 121.351253] Testing event ext4_other_inode_update_time: OK
[ 121.421776] Testing event jbd2_lock_buffer_stall: OK
[ 121.481529] Testing event jbd2_write_superblock: OK
[ 121.541309] Testing event jbd2_update_log_tail: OK
[ 121.601584] Testing event jbd2_checkpoint_stats: OK
[ 121.661546] Testing event jbd2_run_stats: OK
[ 121.711540] Testing event jbd2_handle_stats: OK
[ 121.771226] Testing event jbd2_handle_extend: OK
[ 121.831515] Testing event jbd2_handle_start: OK
[ 121.891183] Testing event jbd2_submit_inode_data: OK
[ 121.951475] Testing event jbd2_end_commit: OK
[ 122.001486] Testing event jbd2_drop_transaction: OK
[ 122.061475] Testing event jbd2_commit_logging: OK
[ 122.121477] Testing event jbd2_commit_flushing: OK
[ 122.181426] Testing event jbd2_commit_locking: OK
[ 122.241376] Testing event jbd2_start_commit: OK
[ 122.301567] Testing event jbd2_checkpoint: OK
[ 122.351134] Testing event block_rq_remap: OK
[ 122.401307] Testing event block_bio_remap: OK
[ 122.451048] Testing event block_split: OK
[ 122.501445] Testing event block_unplug: OK
[ 122.551212] Testing event block_plug: OK
[ 122.601282] Testing event block_sleeprq: OK
[ 122.650936] Testing event block_getrq: OK
[ 122.701428] Testing event block_bio_queue: OK
[ 122.751071] Testing event block_bio_frontmerge: OK
[ 122.811001] Testing event block_bio_backmerge: OK
[ 122.870972] Testing event block_bio_complete: OK
[ 122.930943] Testing event block_bio_bounce: OK
[ 122.980703] Testing event block_rq_issue: OK
[ 123.030989] Testing event block_rq_insert: OK
[ 123.080953] Testing event block_rq_complete: OK
[ 123.140943] Testing event block_rq_requeue: OK
[ 123.200732] Testing event block_rq_abort: OK
[ 123.250898] Testing event block_dirty_buffer: OK
[ 123.310755] Testing event block_touch_buffer: OK
[ 123.370813] Testing event urandom_read: OK
[ 123.420807] Testing event random_read: OK
[ 123.470594] Testing event extract_entropy_user: OK
[ 123.530830] Testing event extract_entropy: OK
[ 123.581114] Testing event get_random_bytes_arch: OK
[ 123.640603] Testing event get_random_bytes: OK
[ 123.690776] Testing event xfer_secondary_pool: OK
[ 123.750797] Testing event add_disk_randomness: OK
[ 123.810581] Testing event add_input_randomness: OK
[ 123.870912] Testing event debit_entropy: OK
[ 123.920839] Testing event push_to_pool: OK
[ 123.970842] Testing event credit_entropy_bits: OK
[ 124.030862] Testing event mix_pool_bytes_nolock: OK
[ 124.090878] Testing event mix_pool_bytes: OK
[ 124.140653] Testing event add_device_randomness: OK
[ 124.200986] Testing event scsi_eh_wakeup: OK
[ 124.250900] Testing event scsi_dispatch_cmd_timeout: OK
[ 124.310921] Testing event scsi_dispatch_cmd_done: OK
[ 124.371006] Testing event scsi_dispatch_cmd_error: OK
[ 124.430988] Testing event scsi_dispatch_cmd_start: OK
[ 124.490957] Testing event ata_eh_link_autopsy_qc: OK
[ 124.550983] Testing event ata_eh_link_autopsy: OK
[ 124.611169] Testing event ata_qc_complete_done: OK
[ 124.670954] Testing event ata_qc_complete_failed: OK
[ 124.730641] Testing event ata_qc_complete_internal: OK
[ 124.790917] Testing event ata_qc_issue: OK
[ 124.840919] Testing event udp_fail_queue_rcv_skb: OK
[ 124.900909] Testing event sock_exceed_buf_limit: OK
[ 124.960940] Testing event sock_rcvqueue_full: OK
[ 125.021118] Testing event napi_poll: OK
[ 125.070941] Testing event netif_rx_ni_entry: OK
[ 125.130911] Testing event netif_rx_entry: OK
[ 125.180680] Testing event netif_receive_skb_entry: OK
[ 125.240980] Testing event napi_gro_receive_entry: OK
[ 125.300660] Testing event napi_gro_frags_entry: OK
[ 125.360962] Testing event netif_rx: OK
[ 125.410848] Testing event netif_receive_skb: OK
[ 125.470808] Testing event net_dev_queue: OK
[ 125.520818] Testing event net_dev_xmit: OK
[ 125.570753] Testing event net_dev_start_xmit: OK
[ 125.630710] Testing event skb_copy_datagram_iovec: OK
[ 125.690709] Testing event consume_skb: OK
[ 125.740525] Testing event kfree_skb: OK
[ 125.790844] Running tests on trace event systems:
[ 125.832325] Testing event system skb: OK
[ 125.882834] Testing event system net: OK
[ 125.932068] Testing event system napi: OK
[ 125.981285] Testing event system sock: OK
[ 126.031262] Testing event system udp: OK
[ 126.081239] Testing event system libata: OK
[ 126.131616] Testing event system scsi: OK
[ 126.181453] Testing event system random: OK
[ 126.232440] Testing event system block: OK
[ 126.282603] Testing event system jbd2: OK
[ 126.332346] Testing event system ext4: OK
[ 126.400100] Testing event system filelock: OK
[ 126.461122] Testing event system writeback: OK
[ 126.523266] Testing event system migrate: OK
[ 126.580922] Testing event system compaction: OK
[ 126.641635] Testing event system kmem: OK
[ 126.691691] Testing event system vmscan: OK
[ 126.741880] Testing event system pagemap: OK
[ 126.800495] Testing event system oom: OK
[ 126.850800] Testing event system filemap: OK
[ 126.900778] Testing event system rpm: OK
[ 126.950933] Testing event system power: OK
[ 127.002532] Testing event system test: OK
[ 127.050533] Testing event system module: OK
[ 127.100758] Testing event system timer: OK
[ 127.151608] Testing event system rcu: OK
[ 127.200363] Testing event system printk: OK
[ 127.250363] Testing event system lock: OK
[ 127.302560] Testing event system sched: OK
[ 127.362124] Testing event system workqueue: OK
[ 127.420457] Testing event system signal: OK
[ 127.470556] Testing event system irq: OK
[ 127.520862] Testing event system task: OK
[ 127.570531] Testing event system raw_syscalls: OK
[ 127.630544] Running tests on all trace events:
[ 127.668475] Testing all events: OK
[ 127.805073] Running tests again, along with the function tracer
[ 127.874088] Running tests on trace events:
[ 127.922026] Testing event sys_exit: OK
[ 128.058250] Testing event sys_enter: OK
[ 128.129245] Testing event task_rename: OK
[ 128.207855] Testing event task_newtask: OK
[ 128.278416] Testing event softirq_raise: OK
[ 128.357587] Testing event softirq_exit: OK
[ 128.428613] Testing event softirq_entry: OK
[ 128.507441] Testing event irq_handler_exit: OK
[ 128.588926] Testing event irq_handler_entry: OK
[ 128.668478] Testing event signal_deliver: OK
[ 128.748481] Testing event signal_generate: OK
[ 128.828439] Testing event workqueue_execute_end: OK
[ 128.908786] Testing event workqueue_execute_start: OK
[ 128.998243] Testing event workqueue_activate_work: OK
[ 129.088956] Testing event workqueue_queue_work: OK
[ 129.169894] Testing event sched_wake_idle_without_ipi: OK
[ 129.258935] Testing event sched_swap_numa: OK
[ 129.338969] Testing event sched_stick_numa: OK
[ 129.418392] Testing event sched_move_numa: OK
[ 129.498397] Testing event sched_process_hang: OK
[ 129.579507] Testing event sched_pi_setprio: OK
[ 129.658782] Testing event sched_stat_runtime: OK
[ 129.738622] Testing event sched_stat_blocked: OK
[ 129.818060] Testing event sched_stat_iowait: OK
[ 129.897979] Testing event sched_stat_sleep: OK
[ 129.978193] Testing event sched_stat_wait: OK
[ 130.057222] Testing event sched_process_exec: OK
[ 130.137818] Testing event sched_process_fork: OK
[ 130.217727] Testing event sched_process_wait: OK
[ 130.297669] Testing event sched_wait_task: OK
[ 130.378027] Testing event sched_process_exit: OK
[ 130.458034] Testing event sched_process_free: OK
[ 130.537890] Testing event sched_migrate_task: OK
[ 130.617633] Testing event sched_switch: OK
[ 130.686638] Testing event sched_wakeup_new: OK
[ 130.766834] Testing event sched_wakeup: OK
[ 130.846578] Testing event sched_kthread_stop_ret: OK
[ 130.927341] Testing event sched_kthread_stop: OK
[ 131.007719] Testing event lock_release: OK
[ 131.087529] Testing event lock_acquire: OK
[ 131.166804] Testing event console: OK
[ 131.236970] Testing event rcu_utilization: OK
[ 131.316633] Testing event tick_stop: OK
[ 131.387459] Testing event itimer_expire: OK
[ 131.467406] Testing event itimer_state: OK
[ 131.537207] Testing event hrtimer_cancel: OK
[ 131.617683] Testing event hrtimer_expire_exit: OK
[ 131.697045] Testing event hrtimer_expire_entry: OK
[ 131.777297] Testing event hrtimer_start: OK
[ 131.856263] Testing event hrtimer_init: OK
[ 131.927544] Testing event timer_cancel: OK
[ 131.997159] Testing event timer_expire_exit: OK
[ 132.077289] Testing event timer_expire_entry: OK
[ 132.157508] Testing event timer_start: OK
[ 132.227874] Testing event timer_init: OK
[ 132.297540] Testing event module_request: OK
[ 132.377317] Testing event module_put: OK
[ 132.448082] Testing event module_get: OK
[ 132.517088] Testing event module_free: OK
[ 132.587139] Testing event module_load: OK
[ 132.656873] Testing event ftrace_test_filter: OK
[ 132.737037] Testing event dev_pm_qos_remove_request: OK
[ 132.827559] Testing event dev_pm_qos_update_request: OK
[ 132.917427] Testing event dev_pm_qos_add_request:
[ 132.987016] test-events (821) used greatest stack depth: 7256 bytes left
[ 133.110909] OK
[ 133.129162] Testing event pm_qos_update_flags: OK
[ 133.208344] Testing event pm_qos_update_target: OK
[ 133.287509] Testing event pm_qos_update_request_timeout: OK
[ 133.378204] Testing event pm_qos_remove_request: OK
[ 133.467659] Testing event pm_qos_update_request: OK
[ 133.548532] Testing event pm_qos_add_request: OK
[ 133.637703] Testing event power_domain_target: OK
[ 133.718855] Testing event clock_set_rate: OK
[ 133.798407] Testing event clock_disable: OK
[ 133.878284] Testing event clock_enable: OK
[ 133.956939] Testing event wakeup_source_deactivate: OK
[ 134.048744] Testing event wakeup_source_activate: OK
[ 134.138593] Testing event suspend_resume: OK
[ 134.219307] Testing event device_pm_callback_end: OK
[ 134.307959] Testing event device_pm_callback_start: OK
[ 134.398501] Testing event cpu_frequency: OK
[ 134.478365] Testing event pstate_sample: OK
[ 134.558565] Testing event cpu_idle: OK
[ 134.628803] Testing event rpm_return_int: OK
[ 134.708782] Testing event rpm_idle: OK
[ 134.778463] Testing event rpm_resume: OK
[ 134.857837] Testing event rpm_suspend: OK
[ 134.928202] Testing event mm_filemap_add_to_page_cache: OK
[ 135.018383] Testing event mm_filemap_delete_from_page_cache: OK
[ 135.118156] Testing event oom_score_adj_update: OK
[ 135.197781] Testing event mm_lru_activate: OK
[ 135.277850] Testing event mm_lru_insertion: OK
[ 135.357678] Testing event mm_vmscan_lru_shrink_inactive: OK
[ 135.448556] Testing event mm_vmscan_writepage: OK
[ 135.527975] Testing event mm_vmscan_memcg_isolate: OK
[ 135.617617] Testing event mm_vmscan_lru_isolate: OK
[ 135.706914] Testing event mm_shrink_slab_end: OK
[ 135.787685] Testing event mm_shrink_slab_start: OK
[ 135.867918] Testing event mm_vmscan_memcg_softlimit_reclaim_end: OK
[ 135.967245] Testing event mm_vmscan_memcg_reclaim_end: OK
[ 136.057780] Testing event mm_vmscan_direct_reclaim_end: OK
[ 136.147694] Testing event mm_vmscan_memcg_softlimit_reclaim_begin: OK
[ 136.247126] Testing event mm_vmscan_memcg_reclaim_begin: OK
[ 136.337559] Testing event mm_vmscan_direct_reclaim_begin: OK
[ 136.427710] Testing event mm_vmscan_wakeup_kswapd: OK
[ 136.517638] Testing event mm_vmscan_kswapd_wake: OK
[ 136.607376] Testing event mm_vmscan_kswapd_sleep: OK
[ 136.697003] Testing event mm_page_alloc_extfrag: OK
[ 136.787082] Testing event mm_page_pcpu_drain: OK
[ 136.867919] Testing event mm_page_alloc_zone_locked: OK
[ 136.958042] Testing event mm_page_alloc: OK
[ 137.037803] Testing event mm_page_free_batched: OK
[ 137.117960] Testing event mm_page_free: OK
[ 137.197531] Testing event kmem_cache_free: OK
[ 137.277661] Testing event kfree: OK
[ 137.347894] Testing event kmem_cache_alloc_node: OK
[ 137.436772] Testing event kmalloc_node: OK
[ 137.507099] Testing event kmem_cache_alloc: OK
[ 137.587019] Testing event kmalloc: OK
[ 137.657623] Testing event mm_compaction_defer_reset: OK
[ 137.747873] Testing event mm_compaction_defer_compaction: OK
[ 137.846706] Testing event mm_compaction_deferred: OK
[ 137.936466] Testing event mm_compaction_suitable: OK
[ 138.026565] Testing event mm_compaction_finished: OK
[ 138.115932] Testing event mm_compaction_try_to_compact_pages: OK
[ 138.217217] Testing event mm_compaction_end: OK
[ 138.296322] Testing event mm_compaction_begin: OK
[ 138.377292] Testing event mm_compaction_migratepages: OK
[ 138.467255] Testing event mm_compaction_isolate_freepages: OK
[ 138.565943] Testing event mm_compaction_isolate_migratepages: OK
[ 138.667334] Testing event mm_numa_migrate_ratelimit: OK
[ 138.756878] Testing event mm_migrate_pages: OK
[ 138.838058] Testing event writeback_dirty_inode_enqueue: OK
[ 138.927333] Testing event writeback_lazytime_iput: OK
[ 139.017570] Testing event writeback_lazytime: OK
[ 139.097324] Testing event writeback_single_inode: OK
[ 139.186003] Testing event writeback_single_inode_start: OK
[ 139.277378] Testing event writeback_wait_iff_congested: OK
[ 139.367039] Testing event writeback_congestion_wait: OK
[ 139.457932] Testing event writeback_sb_inodes_requeue: OK
[ 139.546764] Testing event balance_dirty_pages: OK
[ 139.636260] Testing event bdi_dirty_ratelimit: OK
[ 139.717306] Testing event global_dirty_state: OK
[ 139.797048] Testing event writeback_queue_io: OK
[ 139.876774] Testing event wbc_writepage: OK
[ 139.955784] Testing event writeback_bdi_register: OK
[ 140.036642] Testing event writeback_wake_background: OK
[ 140.127242] Testing event writeback_nowork: OK
[ 140.206321] Testing event writeback_pages_written: OK
[ 140.296964] Testing event writeback_wait: OK
[ 140.376958] Testing event writeback_written: OK
[ 140.457395] Testing event writeback_start: OK
[ 140.537255] Testing event writeback_exec: OK
[ 140.616552] Testing event writeback_queue: OK
[ 140.696990] Testing event writeback_write_inode: OK
[ 140.785301] Testing event writeback_write_inode_start: OK
[ 140.877506] Testing event writeback_dirty_inode: OK
[ 140.965499] Testing event writeback_dirty_inode_start: OK
[ 141.057258] Testing event writeback_mark_inode_dirty: OK
[ 141.146897] Testing event writeback_dirty_page: OK
[ 141.226441] Testing event time_out_leases: OK
[ 141.306798] Testing event generic_delete_lease: OK
[ 141.387003] Testing event generic_add_lease: OK
[ 141.467220] Testing event break_lease_unblock: OK
[ 141.547396] Testing event break_lease_block: OK
[ 141.626714] Testing event break_lease_noblock: OK
[ 141.706538] Testing event ext4_es_shrink: OK
[ 141.786888] Testing event ext4_insert_range: OK
[ 141.867101] Testing event ext4_collapse_range: OK
[ 141.946960] Testing event ext4_es_shrink_scan_exit: OK
[ 142.036557] Testing event ext4_es_shrink_scan_enter: OK
[ 142.126531] Testing event ext4_es_shrink_count: OK
[ 142.206625] Testing event ext4_es_lookup_extent_exit: OK
[ 142.297462] Testing event ext4_es_lookup_extent_enter: OK
[ 142.386427] Testing event ext4_es_find_delayed_extent_range_exit: OK
[ 142.486948] Testing event ext4_es_find_delayed_extent_range_enter: OK
[ 142.595818] Testing event ext4_es_remove_extent: OK
[ 142.676612] Testing event ext4_es_cache_extent: OK
[ 142.765873] Testing event ext4_es_insert_extent: OK
[ 142.846492] Testing event ext4_ext_remove_space_done: OK
[ 142.937316] Testing event ext4_ext_remove_space: OK
[ 143.025381] Testing event ext4_ext_rm_idx: OK
[ 143.106594] Testing event ext4_ext_rm_leaf: OK
[ 143.185694] Testing event ext4_remove_blocks: OK
[ 143.266043] Testing event ext4_ext_show_extent: OK
[ 143.345955] Testing event ext4_get_reserved_cluster_alloc: OK
[ 143.445491] Testing event ext4_find_delalloc_range: OK
[ 143.536006] Testing event ext4_ext_in_cache: OK
[ 143.615942] Testing event ext4_ext_put_in_cache: OK
[ 143.696011] Testing event ext4_get_implied_cluster_alloc_exit: OK
[ 143.796279] Testing event ext4_ext_handle_unwritten_extents: OK
[ 143.896394] Testing event ext4_trim_all_free: OK
[ 143.976675] Testing event ext4_trim_extent: OK
[ 144.056487] Testing event ext4_journal_start_reserved: OK
[ 144.146400] Testing event ext4_journal_start: OK
[ 144.226187] Testing event ext4_load_inode: OK
[ 144.306374] Testing event ext4_ext_load_extent: OK
[ 144.386859] Testing event ext4_ind_map_blocks_exit: OK
[ 144.476714] Testing event ext4_ext_map_blocks_exit: OK
[ 144.566445] Testing event ext4_ind_map_blocks_enter: OK
[ 144.656294] Testing event ext4_ext_map_blocks_enter: OK
[ 144.746259] Testing event ext4_ext_convert_to_initialized_fastpath: OK
[ 144.855653] Testing event ext4_ext_convert_to_initialized_enter: OK
[ 144.956267] Testing event ext4_truncate_exit: OK
[ 145.036438] Testing event ext4_truncate_enter: OK
[ 145.116332] Testing event ext4_unlink_exit: OK
[ 145.196529] Testing event ext4_unlink_enter: OK
[ 145.276488] Testing event ext4_fallocate_exit: OK
[ 145.356634] Testing event ext4_zero_range: OK
[ 145.436342] Testing event ext4_punch_hole: OK
[ 145.516678] Testing event ext4_fallocate_enter: OK
[ 145.599926] Testing event ext4_direct_IO_exit: OK
[ 145.686098] Testing event ext4_direct_IO_enter: OK
[ 145.766175] Testing event ext4_load_inode_bitmap: OK
[ 145.855083] Testing event ext4_read_block_bitmap_load: OK
[ 145.946108] Testing event ext4_mb_buddy_bitmap_load: OK
[ 146.036090] Testing event ext4_mb_bitmap_load: OK
[ 146.116248] Testing event ext4_da_release_space: OK
[ 146.205319] Testing event ext4_da_reserve_space: OK
[ 146.294794] Testing event ext4_da_update_reserve_space: OK
[ 146.386240] Testing event ext4_forget: OK
[ 146.456284] Testing event ext4_mballoc_free: OK
[ 146.536168] Testing event ext4_mballoc_discard: OK
[ 146.615834] Testing event ext4_mballoc_prealloc: OK
[ 146.704080] Testing event ext4_mballoc_alloc: OK
[ 146.785895] Testing event ext4_alloc_da_blocks: OK
[ 146.866080] Testing event ext4_sync_fs: OK
[ 146.944928] Testing event ext4_sync_file_exit: OK
[ 147.025624] Testing event ext4_sync_file_enter: OK
[ 147.105226] Testing event ext4_free_blocks: OK
[ 147.185545] Testing event ext4_allocate_blocks: OK
[ 147.265716] Testing event ext4_request_blocks: OK
[ 147.345749] Testing event ext4_mb_discard_preallocations: OK
[ 147.435495] Testing event ext4_discard_preallocations: OK
[ 147.525520] Testing event ext4_mb_release_group_pa: OK
[ 147.615654] Testing event ext4_mb_release_inode_pa: OK
[ 147.706323] Testing event ext4_mb_new_group_pa: OK
[ 147.785788] Testing event ext4_mb_new_inode_pa: OK
[ 147.865607] Testing event ext4_discard_blocks: OK
[ 147.944961] Testing event ext4_journalled_invalidatepage: OK
[ 148.035299] Testing event ext4_invalidatepage: OK
[ 148.115809] Testing event ext4_releasepage: OK
[ 148.195614] Testing event ext4_readpage: OK
[ 148.274439] Testing event ext4_writepage: OK
[ 148.354655] Testing event ext4_writepages_result: OK
[ 148.434190] Testing event ext4_da_write_pages_extent: OK
[ 148.525730] Testing event ext4_da_write_pages: OK
[ 148.605497] Testing event ext4_writepages: OK
[ 148.685362] Testing event ext4_da_write_end: OK
[ 148.766722] Testing event ext4_journalled_write_end: OK
[ 148.855455] Testing event ext4_write_end: OK
[ 148.935855] Testing event ext4_da_write_begin: OK
[ 149.015614] Testing event ext4_write_begin: OK
[ 149.095606] Testing event ext4_begin_ordered_truncate: OK
[ 149.185554] Testing event ext4_mark_inode_dirty: OK
[ 149.274804] Testing event ext4_drop_inode: OK
[ 149.355938] Testing event ext4_evict_inode: OK
[ 149.435409] Testing event ext4_allocate_inode: OK
[ 149.515346] Testing event ext4_request_inode: OK
[ 149.599222] Testing event ext4_free_inode: OK
[ 149.675493] Testing event ext4_other_inode_update_time: OK
[ 149.765103] Testing event jbd2_lock_buffer_stall: OK
[ 149.855854] Testing event jbd2_write_superblock: OK
[ 149.944460] Testing event jbd2_update_log_tail: OK
[ 150.025737] Testing event jbd2_checkpoint_stats: OK
[ 150.114674] Testing event jbd2_run_stats: OK
[ 150.195685] Testing event jbd2_handle_stats: OK
[ 150.275772] Testing event jbd2_handle_extend: OK
[ 150.355356] Testing event jbd2_handle_start: OK
[ 150.435287] Testing event jbd2_submit_inode_data: OK
[ 150.524286] Testing event jbd2_end_commit: OK
[ 150.605937] Testing event jbd2_drop_transaction: OK
[ 150.694585] Testing event jbd2_commit_logging: OK
[ 150.775232] Testing event jbd2_commit_flushing: OK
[ 150.864521] Testing event jbd2_commit_locking: OK
[ 150.945167] Testing event jbd2_start_commit: OK
[ 151.025446] Testing event jbd2_checkpoint: OK
[ 151.105210] Testing event block_rq_remap: OK
[ 151.184879] Testing event block_bio_remap: OK
[ 151.264779] Testing event block_split: OK
[ 151.334594] Testing event block_unplug: OK
[ 151.403726] Testing event block_plug: OK
[ 151.474759] Testing event block_sleeprq: OK
[ 151.553604] Testing event block_getrq: OK
[ 151.634074] Testing event block_bio_queue: OK
[ 151.714712] Testing event block_bio_frontmerge: OK
[ 151.794188] Testing event block_bio_backmerge: OK
[ 151.874273] Testing event block_bio_complete: OK
[ 151.954099] Testing event block_bio_bounce: OK
[ 152.034627] Testing event block_rq_issue: OK
[ 152.114410] Testing event block_rq_insert: OK
[ 152.193956] Testing event block_rq_complete: OK
[ 152.274324] Testing event block_rq_requeue: OK
[ 152.353532] Testing event block_rq_abort: OK
[ 152.433203] Testing event block_dirty_buffer: OK
[ 152.514195] Testing event block_touch_buffer: OK
[ 152.593882] Testing event urandom_read: OK
[ 152.663770] Testing event random_read: OK
[ 152.733791] Testing event extract_entropy_user: OK
[ 152.813844] Testing event extract_entropy: OK
[ 152.893925] Testing event get_random_bytes_arch: OK
[ 152.973977] Testing event get_random_bytes: OK
[ 153.054498] Testing event xfer_secondary_pool: OK
[ 153.134342] Testing event add_disk_randomness: OK
[ 153.214084] Testing event add_input_randomness: OK
[ 153.294111] Testing event debit_entropy: OK
[ 153.373298] Testing event push_to_pool: OK
[ 153.444574] Testing event credit_entropy_bits: OK
[ 153.524415] Testing event mix_pool_bytes_nolock: OK
[ 153.608547] Testing event mix_pool_bytes: OK
[ 153.684589] Testing event add_device_randomness: OK
[ 153.773941] Testing event scsi_eh_wakeup: OK
[ 153.854699] Testing event scsi_dispatch_cmd_timeout: OK
[ 153.944653] Testing event scsi_dispatch_cmd_done: OK
[ 154.032981] Testing event scsi_dispatch_cmd_error: OK
[ 154.123896] Testing event scsi_dispatch_cmd_start: OK
[ 154.213354] Testing event ata_eh_link_autopsy_qc: OK
[ 154.295058] Testing event ata_eh_link_autopsy: OK
[ 154.374805] Testing event ata_qc_complete_done: OK
[ 154.454597] Testing event ata_qc_complete_failed: OK
[ 154.544619] Testing event ata_qc_complete_internal: OK
[ 154.634505] Testing event ata_qc_issue: OK
[ 154.714087] Testing event udp_fail_queue_rcv_skb: OK
[ 154.803529] Testing event sock_exceed_buf_limit: OK
[ 154.884808] Testing event sock_rcvqueue_full: OK
[ 154.964587] Testing event napi_poll: OK
[ 155.034713] Testing event netif_rx_ni_entry: OK
[ 155.114668] Testing event netif_rx_entry: OK
[ 155.194728] Testing event netif_receive_skb_entry: OK
[ 155.284042] Testing event napi_gro_receive_entry: OK
[ 155.373922] Testing event napi_gro_frags_entry: OK
[ 155.454457] Testing event netif_rx: OK
[ 155.524125] Testing event netif_receive_skb: OK
[ 155.606493] Testing event net_dev_queue: OK
[ 155.684698] Testing event net_dev_xmit: OK
[ 155.763734] Testing event net_dev_start_xmit: OK
[ 155.844750] Testing event skb_copy_datagram_iovec: OK
[ 155.934485] Testing event consume_skb: OK
[ 156.013844] Testing event kfree_skb: OK
[ 156.084579] Running tests on trace event systems:
[ 156.139690] Testing event system skb: OK
[ 156.216431] Testing event system net: OK
[ 156.298893] Testing event system napi: OK
[ 156.375717] Testing event system sock: OK
[ 156.455228] Testing event system udp: OK
[ 156.524907] Testing event system libata: OK
[ 156.606803] Testing event system scsi: OK
[ 156.686414] Testing event system random: OK
[ 156.770887] Testing event system block: OK
[ 156.861683] Testing event system jbd2: OK
[ 156.949521] Testing event system ext4: OK
[ 157.081485] Testing event system filelock: OK
[ 157.176198] Testing event system writeback: OK
[ 157.274016] Testing event system migrate: OK
[ 157.354007] Testing event system compaction: OK
[ 157.438432] Testing event system kmem: OK
[ 157.518831] Testing event system vmscan: OK
[ 157.614440] Testing event system pagemap: OK
[ 157.694126] Testing event system oom: OK
[ 157.763815] Testing event system filemap: OK
[ 157.844298] Testing event system rpm: OK
[ 157.914642] Testing event system power: OK
[ 158.002522] Testing event system test: OK
[ 158.083674] Testing event system module: OK
[ 158.164917] Testing event system timer: OK
[ 158.248528] Testing event system rcu: OK
[ 158.322896] Testing event system printk: OK
[ 158.402866] Testing event system lock: OK
[ 158.484389] Testing event system sched: OK
[ 158.570692] Testing event system workqueue: OK
[ 158.654721] Testing event system signal: OK
[ 158.733597] Testing event system irq: OK
[ 158.805118] Testing event system task: OK
[ 158.883843] Testing event system raw_syscalls: OK
[ 158.963830] Running tests on all trace events:
[ 159.014810] Testing all events: OK
[ 159.356882] Testing ftrace filter: OK
[ 159.446319] Key type encrypted registered
[ 159.494289] rtc-m48t59 rtc-m48t59.0: setting system clock to 2015-07-17 18:40:01 UTC (1437158401)
[ 159.619842] EXT4-fs (sda1): couldn't mount as ext3 due to feature incompatibilities
[ 159.704031] EXT4-fs (sda1): couldn't mount as ext2 due to feature incompatibilities
[ 159.924771] EXT4-fs (sda1): mounted filesystem with ordered data mode. Opts: (null)
[ 160.002483] VFS: Mounted root (ext4 filesystem) readonly on device 8:1.
[ 160.114485] devtmpfs: mounted
[ 162.079289] systemd[1]: Inserted module 'autofs4'
[ 162.369280] random: systemd urandom read with 13 bits of entropy available
[ 162.587983] systemd[1]: systemd 218 running in system mode. (+PAM +AUDIT +SELINUX +IMA +APPARMOR +SMACK +SYSVINIT +UTMP +LIBCRYPTSETUP +GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN)
[ 162.799271] systemd[1]: Detected architecture 'sparc64'.
[ 163.028157] systemd[1]: Set hostname to <u5>.
[ 163.464486] systemd-system- (1149) used greatest stack depth: 6520 bytes left
[ 164.148802] systemd-fstab-g (1152) used greatest stack depth: 4744 bytes left
[ 166.075224] systemd[1]: Cannot add dependency job for unit display-manager.service, ignoring: Unit display-manager.service failed to load: No such file or directory.
[ 166.255871] systemd[1]: Starting Arbitrary Executable File Formats File System Automount Point.
[ 166.469391] systemd[1]: Set up automount Arbitrary Executable File Formats File System Automount Point.
[ 166.574904] systemd[1]: Expecting device dev-sda2.device...
[ 166.699785] systemd[1]: Starting Dispatch Password Requests to Console Directory Watch.
[ 166.788226] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[ 166.871940] systemd[1]: Starting Root Slice.
[ 166.969284] systemd[1]: Created slice Root Slice.
[ 167.013738] systemd[1]: Starting Syslog Socket.
[ 167.129256] systemd[1]: Listening on Syslog Socket.
[ 167.175766] systemd[1]: Starting Journal Socket (/dev/log).
[ 167.309237] systemd[1]: Listening on Journal Socket (/dev/log).
[ 167.368789] systemd[1]: Starting Journal Audit Socket.
[ 167.479183] systemd[1]: Listening on Journal Audit Socket.
[ 167.532758] systemd[1]: Starting User and Session Slice.
[ 167.669415] systemd[1]: Created slice User and Session Slice.
[ 167.725972] systemd[1]: Starting /dev/initctl Compatibility Named Pipe.
[ 167.889152] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[ 167.960300] systemd[1]: Starting Journal Socket.
[ 168.059108] systemd[1]: Listening on Journal Socket.
[ 168.106714] systemd[1]: Starting udev Kernel Socket.
[ 168.229087] systemd[1]: Listening on udev Kernel Socket.
[ 168.280535] systemd[1]: Starting udev Control Socket.
[ 168.399065] systemd[1]: Listening on udev Control Socket.
[ 168.450918] systemd[1]: Starting Remote File Systems (Pre).
[ 168.579025] systemd[1]: Reached target Remote File Systems (Pre).
[ 168.638962] systemd[1]: Starting Encrypted Volumes.
[ 168.758999] systemd[1]: Reached target Encrypted Volumes.
[ 168.810432] systemd[1]: Starting Forward Password Requests to Wall Directory Watch.
[ 168.891248] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[ 168.969127] systemd[1]: Starting Paths.
[ 169.058953] systemd[1]: Reached target Paths.
[ 169.097907] systemd[1]: Starting Delayed Shutdown Socket.
[ 169.228944] systemd[1]: Listening on Delayed Shutdown Socket.
[ 169.284561] systemd[1]: Starting System Slice.
[ 169.378892] systemd[1]: Created slice System Slice.
[ 169.427100] systemd[1]: Mounting Debug File System...
[ 169.534489] systemd[1]: Starting system-serial\x2dgetty.slice.
[ 169.689757] systemd[1]: Created slice system-serial\x2dgetty.slice.
[ 169.761820] systemd[1]: Mounting Huge Pages File System...
[ 169.913105] systemd[1]: Starting system-getty.slice.
[ 170.139460] systemd[1]: Created slice system-getty.slice.
[ 170.218850] systemd[1]: Starting Journal Service...
[ 170.370607] systemd[1]: Starting udev Coldplug all Devices...
[ 170.547303] systemd[1]: Starting Slices.
[ 170.659677] systemd[1]: Reached target Slices.
[ 170.953945] systemd[1]: Starting Load Kernel Modules...
[ 171.286810] systemd[1]: Mounting POSIX Message Queue File System...
[ 171.665586] systemd[1]: Starting File System Check on Root Device...
[ 172.010035] systemd[1]: Starting Create list of required static device nodes for the current kernel...
[ 172.710452] systemd[1]: Started Set Up Additional Binary Formats.
[ 172.847687] systemd[1]: Expecting device dev-ttyS0.device...
[ 173.016392] systemd[1]: Mounted Debug File System.
[ 173.159896] systemd[1]: Mounted Huge Pages File System.
[ 173.331049] systemd[1]: Mounted POSIX Message Queue File System.
[ 173.768130] systemd[1]: Started Load Kernel Modules.
[ 174.108139] systemd[1]: Started File System Check on Root Device.
[ 174.471637] systemd[1]: Started Create list of required static device nodes for the current kernel.
[ 174.918039] systemd[1]: Started Journal Service.
[ 178.947464] blk_update_request: I/O error, dev fd0, sector 0
[ 179.001972] floppy: error -5 while reading block 0
[ 180.737967] PCI: Enabling device: (0000:01:01.1), cmd 2
[ 180.738173] sunhme.c:v3.10 August 26, 2008 David S. Miller (davem@...emloft.net)
[ 180.831211] eth0: HAPPY MEAL (PCI/CheerIO) 10/100BaseT Ethernet 08:00:20:f8:c7:72
[ 181.440052] sd 0:0:0:0: Attached scsi generic sg0 type 0
[ 181.876958] sr 1:0:0:0: Attached scsi generic sg1 type 5
[ 182.347615] cdrom_id (1485) used greatest stack depth: 4552 bytes left
[ 182.541054] ls (1487) used greatest stack depth: 4216 bytes left
[ 188.237648] Adding 1984016k swap on /dev/sda2. Priority:-1 extents:1 across:1984016k
[ 189.973232] EXT4-fs (sda1): re-mounted. Opts: errors=remount-ro
[ 191.015816] systemd-udevd (1449) used greatest stack depth: 3624 bytes left
[ 191.467447] systemd-journald[1165]: Received request to flush runtime journal from PID 1
[ 200.653020] eth0: Link is up using internal transceiver at 100Mb/s, Full Duplex.
[ 291.022113] random: nonblocking pool is initialized
--
Meelis Roos (mroos@...ux.ee)
--
To unsubscribe from this list: send the line "unsubscribe netdev" in
the body of a message to majordomo@...r.kernel.org
More majordomo info at http://vger.kernel.org/majordomo-info.html
Powered by blists - more mailing lists