Linux-Trace-Users Archive on lore.kernel.org
 help / color / Atom feed
* Re: function_profile_enabled not showing Time info
       [not found] ` <20200811205411.2f7748ac@oasis.local.home>
@ 2020-08-12  9:46   ` Ahmed Zaki
  0 siblings, 0 replies; only message in thread
From: Ahmed Zaki @ 2020-08-12  9:46 UTC (permalink / raw)
  To: Steven Rostedt; +Cc: linux-trace-users, linux-trace-devel

On Wed, 12 Aug 2020 at 02:54, Steven Rostedt <rostedt@goodmis.org> wrote:
>
> On Wed, 12 Aug 2020 00:35:24 +0200
> Ahmed Zaki <anzaki@gmail.com> wrote:
>
> > Hello,
> >
> > I am trying to use function_profile_enabled on a MIPS machine but only
> > the HITS column is showing numbers. Time and Avg are showing all
> > Zeros.
>
> What clock are you using?
>
>  cat /sys/kernel/debug/tracing/trace_clock
>
> And also supply the dmesg output, so I can see if there's an issue with
> the clock being used.
>
> -- Steve
>
>
> >
> > This is my .config file:
> >
> > CONFIG_FTRACE=y
> > CONFIG_FUNCTION_TRACER=y
> > CONFIG_FUNCTION_GRAPH_TRACER=y
> > CONFIG_IRQSOFF_TRACER=y
> > CONFIG_SCHED_TRACER=y
> > CONFIG_DYNAMIC_FTRACE=y
> >
> > Am I missing something?
> >
> > Thanks.
>

# cat /sys/kernel/debug/tracing/trace_clock
[local] global counter uptime perf mono mono_raw boot

I tried all of them and still getting zeros in TIme and Avg

And below is dmesg, thanks.

[    0.000000] Linux version 4.14.171 (ahmed@ahmed-VirtualBox) (gcc
version 5.4.0 (Buildroot 2017.02.4-g3e5f6d5bc-dirty)) #1 Tue Aug 11
13:52:20 MDT 2020
[    0.000000] bootconsole [early0] enabled
[    0.000000] CPU0 revision is: 00019750 (MIPS 74Kc)
[    0.000000] MIPS: machine is UBNT-UAP-AC-M
[    0.000000] SoC: Qualcomm Atheros QCA956X ver 1 rev 0
[    0.000000] Determined physical RAM map:
[    0.000000]  memory: 08000000 @ 00000000 (usable)
[    0.000000] Primary instruction cache 64kB, VIPT, 4-way, linesize 32 bytes.
[    0.000000] Primary data cache 32kB, 4-way, VIPT, cache aliases,
linesize 32 bytes
[    0.000000] Zone ranges:
[    0.000000]   Normal   [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Movable zone start for each node
[    0.000000] Early memory node ranges
[    0.000000]   node   0: [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] Initmem setup node 0 [mem 0x0000000000000000-0x0000000007ffffff]
[    0.000000] On node 0 totalpages: 32768
[    0.000000] free_area_init_node: node 0, pgdat 80640220,
node_mem_map 81007540
[    0.000000]   Normal zone: 256 pages used for memmap
[    0.000000]   Normal zone: 0 pages reserved
[    0.000000]   Normal zone: 32768 pages, LIFO batch:7
[    0.000000] random: get_random_bytes called from
start_kernel+0xa0/0x47c with crng_init=0
[    0.000000] pcpu-alloc: s0 r0 d32768 u32768 alloc=1*32768
[    0.000000] pcpu-alloc: [0] 0
[    0.000000] Built 1 zonelists, mobility grouping on.  Total pages: 32512
[    0.000000] Kernel command line: console=ttyS0,115200n8 rootfstype=jffs2
[    0.000000] PID hash table entries: 512 (order: -1, 2048 bytes)
[    0.000000] Dentry cache hash table entries: 16384 (order: 4, 65536 bytes)
[    0.000000] Inode-cache hash table entries: 8192 (order: 3, 32768 bytes)
[    0.000000] Writing ErrCtl register=00000000
[    0.000000] Readback ErrCtl register=00000000
[    0.000000] Memory: 121536K/131072K available (4158K kernel code,
261K rwdata, 1616K rodata, 1380K init, 525K bss, 9536K reserved, 0K
cma-reserved)
[    0.000000] SLUB: HWalign=32, Order=0-3, MinObjects=0, CPUs=1, Nodes=1
[    0.000000] ftrace: allocating 15925 entries in 32 pages
[    0.000000] NR_IRQS: 51
[    0.000000] CPU clock: 775.000 MHz
[    0.000000] clocksource: MIPS: mask: 0xffffffff max_cycles:
0xffffffff, max_idle_ns: 4932285024 ns
[    0.000007] sched_clock: 32 bits at 387MHz, resolution 2ns, wraps
every 5541893118ns
[    0.008231] Calibrating delay loop... 385.02 BogoMIPS (lpj=192512)
[    0.025759] pid_max: default: 32768 minimum: 301
[    0.030890] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.037891] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[    0.049414] clocksource: jiffies: mask: 0xffffffff max_cycles:
0xffffffff, max_idle_ns: 1911260446275000 ns
[    0.059741] futex hash table entries: 256 (order: 0, 7168 bytes)
[    0.066201] pinctrl core: initialized pinctrl subsystem
[    0.072820] NET: Registered protocol family 16
[    0.084554] PCI host bridge /ahb/pcie-controller@18250000 ranges:
[    0.091038]  MEM 0x0000000012000000..0x0000000013ffffff
[    0.096559]   IO 0x0000000000000000..0x0000000000000000
[    0.122978] PCI host bridge to bus 0000:00
[    0.127348] pci_bus 0000:00: root bus resource [mem 0x12000000-0x13ffffff]
[    0.134602] pci_bus 0000:00: root bus resource [io  0x0000]
[    0.140485] pci_bus 0000:00: root bus resource [??? 0x00000000 flags 0x0]
[    0.147649] pci_bus 0000:00: No busn resource found for root bus,
will use [bus 00-ff]
[    0.156043] pci 0000:00:00.0: [168c:003c] type 00 class 0x028000
[    0.156102] pci 0000:00:00.0: reg 0x10: [mem 0x00000000-0x001fffff 64bit]
[    0.156158] pci 0000:00:00.0: reg 0x30: [mem 0x00000000-0x0000ffff pref]
[    0.156240] pci 0000:00:00.0: supports D1
[    0.156249] pci 0000:00:00.0: PME# supported from D0 D1 D3hot
[    0.156456] pci_bus 0000:00: busn_res: [bus 00-ff] end is updated to 00
[    0.156482] pci 0000:00:00.0: BAR 0: assigned [mem
0x12000000-0x121fffff 64bit]
[    0.164244] pci 0000:00:00.0: BAR 6: assigned [mem
0x12200000-0x1220ffff pref]
[    0.172461] clocksource: Switched to clocksource MIPS
[    0.217220] NET: Registered protocol family 2
[    0.222606] TCP established hash table entries: 1024 (order: 0, 4096 bytes)
[    0.230012] TCP bind hash table entries: 1024 (order: 2, 20480 bytes)
[    0.236904] TCP: Hash tables configured (established 1024 bind 1024)
[    0.243771] UDP hash table entries: 256 (order: 1, 12288 bytes)
[    0.250128] UDP-Lite hash table entries: 256 (order: 1, 12288 bytes)
[    0.257157] NET: Registered protocol family 1
[    0.261846] PCI: CLS 0 bytes, default 32
[    0.268183] workingset: timestamp_bits=30 max_order=15 bucket_order=0
[    0.279278] jffs2: version 2.2 (NAND) (SUMMARY) (LZMA)
(CMODE_PRIORITY) (c) 2001-2006 Red Hat, Inc.
[    0.299629] io scheduler noop registered
[    0.303803] io scheduler deadline registered (default)
[    0.310903] pinctrl-single 1804002c.pinmux: 544 pins at pa b804002c size 68
[    0.319276] Serial: 8250/16550 driver, 1 ports, IRQ sharing disabled
[    0.326750] console [ttyS0] disabled
[    0.330606] 18020000.uart: ttyS0 at MMIO 0x18020000 (irq = 9,
base_baud = 1562500) is a 16550A
[    0.339719] console [ttyS0] enabled
[    0.347287] bootconsole [early0] disabled
[    0.362510] m25p80 spi0.0: mx25l12805d (16384 Kbytes)
[    0.367804] 5 fixed-partitions partitions found on MTD device spi0.0
[    0.374384] Creating 5 MTD partitions on "spi0.0":
[    0.379357] 0x000000000000-0x000000060000 : "u-boot"
[    0.385291] 0x000000060000-0x000000070000 : "u-boot-env"
[    0.391662] 0x000000070000-0x000000f70000 : "firmware"
[    0.401096] 2 uimage-fw partitions found on MTD device firmware
[    0.407258] Creating 2 MTD partitions on "firmware":
[    0.412409] 0x000000000000-0x000000200000 : "kernel"
[    0.418280] 0x000000200000-0x000000f00000 : "rootfs"
[    0.424167] mtd: device 4 (rootfs) set to be root filesystem
[    0.430107] 0x000000f70000-0x000000ff0000 : "cfg"
[    0.435786] 0x000000ff0000-0x000001000000 : "art"
[    0.442294] libphy: Fixed MDIO Bus: probed
[    0.530457] random: fast init done
[    1.071833] libphy: ag71xx_mdio: probed
[    1.131902] ag71xx 19000000.eth: connected to PHY at mdio-bus.0:04
[uid=004dd074, driver=Atheros 8031 ethernet]
[    1.142955] eth0: Atheros AG71xx at 0xb9000000, irq 4, mode: sgmii
[    1.150433] Netfilter messages via NETLINK v0.30.
[    1.155670] nf_conntrack version 0.5.0 (2048 buckets, 8192 max)
[    1.162775] NET: Registered protocol family 10
[    1.171904] Segment Routing with IPv6
[    1.175834] NET: Registered protocol family 17
[    1.180555] Bridge firewalling registered
[    1.184733] 8021q: 802.1Q VLAN Support v1.8
[    4.259284] jffs2: notice: (1) jffs2_build_xattr_subsystem:
complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan)
and 0 of xref (0 dead, 0 orphan) found.
[    4.275688] VFS: Mounted root (jffs2 filesystem) readonly on device 31:4.
[    4.301258] Freeing unused kernel memory: 1380K
[    4.305970] This architecture does not have kernel memory protection.
[    5.310549] jffs2: notice: (308) jffs2_build_xattr_subsystem:
complete building xattr subsystem, 0 of xdatum (0 unchecked, 0 orphan)
and 0 of xref (0 dead, 0 orphan) found.
[    6.330613] random: dd: uninitialized urandom read (512 bytes read)
[    6.525170] random: avahi-daemon: uninitialized urandom read (4 bytes read)
[    6.547278] random: avahi-daemon: uninitialized urandom read (4 bytes read)
[   13.699503] random: crng init done
[   14.526615] Loading modules backported from Linux version
v4.19.98-0-gd183c8e2647a
[   14.534488] Backport generated by backports.git v4.19.98-1-0-g8204eb99
[   18.071321] PCI: Enabling device 0000:00:00.0 (0000 -> 0002)
[   18.077401] ath10k_pci 0000:00:00.0: pci irq legacy oper_irq_mode 1
irq_mode 0 reset_mode 0
[   18.253583] ath10k_pci 0000:00:00.0: Direct firmware load for
ath10k/pre-cal-pci-0000:00:00.0.bin failed with error -2
[   18.264673] ath10k_pci 0000:00:00.0: Falling back to user helper
[   18.282503] ath10k_pci 0000:00:00.0: Direct firmware load for
ath10k/QCA988X/hw2.0/firmware-6.bin failed with error -2
[   18.293580] ath10k_pci 0000:00:00.0: Falling back to user helper
[   18.564289] ath10k_pci 0000:00:00.0: qca988x hw2.0 target
0x4100016c chip_id 0x043222ff sub 0000:0000
[   18.573883] ath10k_pci 0000:00:00.0: kconfig debug 1 debugfs 1
tracing 1 dfs 0 testmode 0
[   18.587016] ath10k_pci 0000:00:00.0: firmware ver 10.2.4.70.70 api
5 features no-p2p,raw-mode,mfp,allows-mesh-bcast crc32 3a226daa
[   18.663342] ath10k_pci 0000:00:00.0: Direct firmware load for
ath10k/QCA988X/hw2.0/board-2.bin failed with error -2
[   18.674165] ath10k_pci 0000:00:00.0: Falling back to user helper
[   18.692404] ath10k_pci 0000:00:00.0: board_file api 1 bmi_id N/A
crc32 bebc7c08
[   19.742442] ath10k_pci 0000:00:00.0: htt-ver 2.1 wmi-op 5 htt-op 2
cal file max-sta 128 raw 0 hwcrypto 1
[   19.833153] ath: EEPROM regdomain: 0x0
[   19.833164] ath: EEPROM indicates default country code should be used
[   19.833168] ath: doing EEPROM country->regdmn map search
[   19.833181] ath: country maps to regdmn code: 0x3a
[   19.833186] ath: Country alpha2 being used: US
[   19.833190] ath: Regpair used: 0x3a
[   20.758095] ath: EEPROM regdomain: 0x0
[   20.758106] ath: EEPROM indicates default country code should be used
[   20.758110] ath: doing EEPROM country->regdmn map search
[   20.758125] ath: country maps to regdmn code: 0x3a
[   20.758130] ath: Country alpha2 being used: US
[   20.758134] ath: Regpair used: 0x3a

^ permalink raw reply	[flat|nested] only message in thread

only message in thread, back to index

Thread overview: (only message) (download: mbox.gz / follow: Atom feed)
-- links below jump to the message on this page --
     [not found] <CANczwAGy1tQe1yhgnwhfStGCfh4iFvMei_AqPEvTbLmmPBWatg@mail.gmail.com>
     [not found] ` <20200811205411.2f7748ac@oasis.local.home>
2020-08-12  9:46   ` function_profile_enabled not showing Time info Ahmed Zaki

Linux-Trace-Users Archive on lore.kernel.org

Archives are clonable:
	git clone --mirror https://lore.kernel.org/linux-trace-users/0 linux-trace-users/git/0.git

	# If you have public-inbox 1.1+ installed, you may
	# initialize and index your mirror using the following commands:
	public-inbox-init -V2 linux-trace-users linux-trace-users/ https://lore.kernel.org/linux-trace-users \
		linux-trace-users@vger.kernel.org
	public-inbox-index linux-trace-users

Example config snippet for mirrors

Newsgroup available over NNTP:
	nntp://nntp.lore.kernel.org/org.kernel.vger.linux-trace-users


AGPL code for this site: git clone https://public-inbox.org/public-inbox.git