Tool/software: Linux
Hi all,
I want to achieve a precised (in us range) time synchronisation between two 66AK2E05 SOCs connected via 1 Ethernet cable and running under Linux on ARM side . The Goal is to be able for example to measure latency of known events, compare timestamped data, etc. After reading the TI documentation, I thought the cpts module should be the perfect component to use. The idea was to use ptp protocol in my application to synchronize clocks via cpts component. I started one feasibility test but it is not working as expected, that is to say Hardware timestamping does not seem to be available with my configuration.
Here is the process I followed:
- I compiled 4.4.34-02701-g988ab9c GNU/Linux kernel (TI git repository) with CONFIG_PPS, CONFIG_NETWORK_PHY_TIMESTAMPING, PTP_1588_CLOCK enabled via make menuconfig
- I used standard cpts settings in device tree (from Processor SDK):
netcp-devices {
#address-cells = <1>;
#size-cells = <1>;
ranges;
gbe@200000 { /* ETHSS */
label = "netcp-gbe";
compatible = "ti,netcp-gbe-9";
syscon-subsys = <&gbe_subsys>;
reg = <0x200100 0x800>, <0x220000 0x20000>;
enable-ale;
tx-queue = <896>;
tx-channel = "nettx";
cpts-rftclk-sel = <0>;
cpts-ext-ts-inputs = <6>;
3. I checked then Linux startup log and the Ethernet capabilities after Startup:
ethtool -T eth0:
---------------
Capabilities:
software-transmit (SOF_TIMESTAMPING_TX_SOFTWARE)
software-receive (SOF_TIMESTAMPING_RX_SOFTWARE)
software-system-clock (SOF_TIMESTAMPING_SOFTWARE)
PTP Hardware Clock: none
Hardware Transmit Timestamp Modes: none
Hardware Receive Filter Modes: None
Linux boot log:
--------------
[ 0.174029] pps_core: LinuxPPS API ver. 1 registered
[ 0.174035] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[ 0.174089] PTP clock support registered
[ 0.174875] clocksource: Switched to clocksource arch_sys_counter
......
[ OK ] Started Network Time Synchronization.
[ OK ] Reached target System Time Synchronized.
Starting Synchronize System and HW clocks...
[ FAILED ] Failed to start Synchronize System and HW clocks.
See 'systemctl status sync-clocks.service' for details.
systemctl status sync-clocks.service:
------------------------------------
sync-clocks.service - Synchronize System and HW clocks
Loaded: loaded (/etc/systemd/system/sync-clocks.service; enabled; vendor preset: enabled)
Active: (Result: exit-code) since Fri 2016-12-16 14:55:00 UTC; 10min ago
Process: 2311 ExecStart=/sbin/hwclock --systohc (code=exited,status=1/FAILURE)
Main PID: 2311 (code=exited, status=1/FAILURE)
Dec 16 14:55:00 k2e-evm systemd[1]: Starting Synchronize System and HW clocks...
Dec 16 14:55:00 k2e-evm hwclock[2311]: hwclock: can't open '/dev/misc/rtc': No such file or directory
Dec 16 14:55:00 k2e-evm systemd[1]: sync-clocks.service: Main process exited, code=exited, status=1/FAILURE
Dec 16 14:55:00 k2e-evm systemd[1]: Failed to start Synchronize System and HW clocks.
Dec 16 14:55:00 k2e-evm systemd[1]: sync-clocks.service: Unit entered failed state.
Dec 16 14:55:00 k2e-evm systemd[1]: sync-clocks.service: Failedwith result 'exit-code'.
Questions: Did I miss something in configuration? Is there a better way to achieve this?
Log above is only a sample, see full log in attachment.
boot
ubi0: attaching mtd1
ubi0: scanning is finished
ubi0: attached mtd1 (name "mtd=2", size 510 MiB)
ubi0: PEB size: 131072 bytes (128 KiB), LEB size: 126976 bytes
ubi0: min./max. I/O unit sizes: 2048/2048, sub-page size 2048
ubi0: VID header offset: 2048 (aligned 2048), data offset: 4096
ubi0: good PEBs: 4080, bad PEBs: 4, corrupted PEBs: 0
ubi0: user volume: 1, internal volumes: 1, max. volumes count: 128
ubi0: max/mean erase counter: 3/0, WL threshold: 4096, image sequence number: 1710674976
ubi0: available PEBs: 0, total reserved PEBs: 4080, PEBs reserved for bad PEB handling: 76
Loading file '/boot/k2-fw-initrd.cpio.gz' to addr 0x88080000...
Done
Loading file '/boot/keystone-k2e-et.dtb' to addr 0x88000000...
Done
Loading file '/boot/skern-k2e.bin' to addr 0x0c140000...
Done
Loading file '/boot/zImageHWTime' to addr 0x82000000...
Done
K2_BM_15.07-39-g035329c SoC:k2e built:18:01:05, Oct 3 2016
## installed monitor, freq [208333333], status 0
Kernel image @ 0x82000000 [ 0x000000 - 0x40eeb8 ]
## Flattened Device Tree blob at 88000000
Booting using the fdt blob at 0x88000000
Loading Ramdisk to 8fff0000, end 8ffffd84 ... OK
Loading Device Tree to 8ffe5000, end 8ffef75b ... OK
Starting kernel ...
[ 0.000000] Booting Linux on physical CPU 0x0
[ 0.000000] Initializing cgroup subsys cpu
[ 0.000000] Initializing cgroup subsys cpuacct
[ 0.000000] Linux version 4.4.34-02701-g988ab9c (ziemer@ubuntu) (gcc version 4.8.4 (Ubuntu/Linaro 4.8.4-2ubuntu1~14.04.1) ) #3 SMP PREEMPT Wed Feb 8 15:59:18 CET 2017
[ 0.000000] CPU: ARMv7 Processor [412fc0f4] revision 4 (ARMv7), cr=30c5387d
[ 0.000000] CPU: PIPT / VIPT nonaliasing data cache, PIPT instruction cache
[ 0.000000] Machine model: Texas Instruments Keystone 2 Edison EVM
[ 0.000000] Switching physical address space to 0x800000000
[ 0.000000] Reserved memory: created CMA memory pool at 0x000000081f800000, size 8 MiB
[ 0.000000] Reserved memory: initialized node dsp_common_cma_pool, compatible id shared-dma-pool
[ 0.000000] Reserved memory: created DMA memory pool at 0x0000000820000000, size 512 MiB
[ 0.000000] Reserved memory: initialized node dsp_reserved_mpm_area, compatible id shared-dma-pool
[ 0.000000] cma: Reserved 16 MiB at 0x000000087ec00000
[ 0.000000] Forcing write-allocate cache policy for SMP
[ 0.000000] Memory policy: Data cache writealloc
[ 0.000000] psci: probing for conduit method from DT.
[ 0.000000] psci: Using PSCI v0.1 Function IDs from DT
[ 0.000000] PERCPU: Embedded 13 pages/cpu @dd799000 s21248 r8192 d23808 u53248
[ 0.000000] Built 1 zonelists in Zone order, mobility grouping on. Total pages: 915968
[ 0.000000] Kernel command line: console=ttyS0,115200n8 rootwait=1 rootfstype=ubifs root=ubi0:rootfs rootflags=sync rw ubi.mtd=ubifs,2048
[ 0.000000] log_buf_len individual max cpu contribution: 4096 bytes
[ 0.000000] log_buf_len total cpu_extra contributions: 12288 bytes
[ 0.000000] log_buf_len min size: 16384 bytes
[ 0.000000] log_buf_len: 32768 bytes
[ 0.000000] early log buf free: 14104(86%)
[ 0.000000] PID hash table entries: 2048 (order: 1, 8192 bytes)
[ 0.000000] Dentry cache hash table entries: 65536 (order: 6, 262144 bytes)
[ 0.000000] Inode-cache hash table entries: 32768 (order: 5, 131072 bytes)
[ 0.000000] Memory: 3607168K/3670016K available (5754K kernel code, 365K rwdata, 1956K rodata, 360K init, 200K bss, 38272K reserved, 24576K cma-reserved, 3129344K highmem)
[ 0.000000] Virtual kernel memory layout:
[ 0.000000] vector : 0xffff0000 - 0xffff1000 ( 4 kB)
[ 0.000000] fixmap : 0xffc00000 - 0xfff00000 (3072 kB)
[ 0.000000] vmalloc : 0xf0800000 - 0xff800000 ( 240 MB)
[ 0.000000] lowmem : 0xc0000000 - 0xf0000000 ( 768 MB)
[ 0.000000] pkmap : 0xbfe00000 - 0xc0000000 ( 2 MB)
[ 0.000000] modules : 0xbf000000 - 0xbfe00000 ( 14 MB)
[ 0.000000] .text : 0xc0008000 - 0xc078fc34 (7712 kB)
[ 0.000000] .init : 0xc0790000 - 0xc07ea000 ( 360 kB)
[ 0.000000] .data : 0xc07ea000 - 0xc08454d4 ( 366 kB)
[ 0.000000] .bss : 0xc0848000 - 0xc087a040 ( 201 kB)
[ 0.000000] SLUB: HWalign=64, Order=0-3, MinObjects=0, CPUs=4, Nodes=1
[ 0.000000] Preemptible hierarchical RCU implementation.
[ 0.000000] Build-time adjustment of leaf fanout to 32.
[ 0.000000] NR_IRQS:16 nr_irqs:16 16
[ 0.000000] Architected cp15 timer(s) running at 208.33MHz (virt).
[ 0.000000] clocksource: arch_sys_counter: mask: 0xffffffffffffff max_cycles: 0x300c4cdf1c, max_idle_ns: 440795202901 ns
[ 0.000003] sched_clock: 56 bits at 208MHz, resolution 4ns, wraps every 4398046511101ns
[ 0.000011] Switching to timer-based delay loop, resolution 4ns
[ 0.000128] keystone timer clock @208333333 Hz
[ 0.000268] Console: colour dummy device 80x30
[ 0.000283] Calibrating delay loop (skipped), value calculated using timer frequency.. 416.66 BogoMIPS (lpj=2083333)
[ 0.000293] pid_max: default: 4096 minimum: 301
[ 0.000361] Mount-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000369] Mountpoint-cache hash table entries: 1024 (order: 0, 4096 bytes)
[ 0.000772] Initializing cgroup subsys io
[ 0.000785] Initializing cgroup subsys devices
[ 0.000796] Initializing cgroup subsys freezer
[ 0.000812] CPU: Testing write buffer coherency: ok
[ 0.000978] /cpus/cpu@0 missing clock-frequency property
[ 0.000997] /cpus/cpu@1 missing clock-frequency property
[ 0.001015] /cpus/cpu@2 missing clock-frequency property
[ 0.001034] /cpus/cpu@3 missing clock-frequency property
[ 0.001042] CPU0: thread -1, cpu 0, socket 0, mpidr 80000000
[ 0.001077] Setting up static identity map for 0x800082c0 - 0x800083cc
[ 0.084708] CPU1: thread -1, cpu 1, socket 0, mpidr 80000001
[ 0.114749] CPU2: thread -1, cpu 2, socket 0, mpidr 80000002
[ 0.144778] CPU3: thread -1, cpu 3, socket 0, mpidr 80000003
[ 0.144858] Brought up 4 CPUs
[ 0.144873] SMP: Total of 4 processors activated (1666.66 BogoMIPS).
[ 0.144879] CPU: All CPU(s) started in SVC mode.
[ 0.145214] devtmpfs: initialized
[ 0.151800] VFP support v0.3: implementor 41 architecture 4 part 30 variant f rev 0
[ 0.152110] clocksource: jiffies: mask: 0xffffffff max_cycles: 0xffffffff, max_idle_ns: 19112604462750000 ns
[ 0.152587] pinctrl core: initialized pinctrl subsystem
[ 0.152867] NET: Registered protocol family 16
[ 0.153593] DMA: preallocated 256 KiB pool for atomic coherent allocations
[ 0.160399] irq: no irq domain found for /soc/keystone_irq@26202a0 !
[ 0.162481] hw-breakpoint: found 5 (+1 reserved) breakpoint and 4 watchpoint registers.
[ 0.162488] hw-breakpoint: maximum watchpoint size is 8 bytes.
[ 0.172087] vgaarb: loaded
[ 0.172368] SCSI subsystem initialized
[ 0.172755] usbcore: registered new interface driver usbfs
[ 0.172835] usbcore: registered new interface driver hub
[ 0.172930] usbcore: registered new device driver usb
[ 0.174029] pps_core: LinuxPPS API ver. 1 registered
[ 0.174035] pps_core: Software ver. 5.3.6 - Copyright 2005-2007 Rodolfo Giometti <giometti@linux.it>
[ 0.174089] PTP clock support registered
[ 0.174875] clocksource: Switched to clocksource arch_sys_counter
[ 0.202775] NET: Registered protocol family 2
[ 0.203195] TCP established hash table entries: 4096 (order: 2, 16384 bytes)
[ 0.203226] TCP bind hash table entries: 4096 (order: 3, 32768 bytes)
[ 0.203279] TCP: Hash tables configured (established 4096 bind 4096)
[ 0.203323] UDP hash table entries: 256 (order: 1, 8192 bytes)
[ 0.203339] UDP-Lite hash table entries: 256 (order: 1, 8192 bytes)
[ 0.203458] NET: Registered protocol family 1
[ 0.203622] RPC: Registered named UNIX socket transport module.
[ 0.203629] RPC: Registered udp transport module.
[ 0.203634] RPC: Registered tcp transport module.
[ 0.203639] RPC: Registered tcp NFSv4.1 backchannel transport module.
[ 0.203796] Unpacking initramfs...
[ 0.207574] Freeing initrd memory: 64K (cfff0000 - d0000000)
[ 0.207704] hw perfevents: enabled with armv7_cortex_a15 PMU driver, 7 counters available
[ 0.208336] platform alarmtimer: set dma_pfn_offset00780000
[ 0.208963] futex hash table entries: 16 (order: -2, 1024 bytes)
[ 0.220516] Installing knfsd (copyright (C) 1996 okir@monad.swb.de).
[ 0.220613] ntfs: driver 2.1.32 [Flags: R/O].
[ 0.220934] jffs2: version 2.2. (NAND) © 2001-2006 Red Hat, Inc.
[ 0.223611] NET: Registered protocol family 38
[ 0.223679] bounce: pool size: 64 pages
[ 0.223897] Block layer SCSI generic (bsg) driver version 0.4 loaded (major 251)
[ 0.223912] io scheduler noop registered
[ 0.223923] io scheduler deadline registered
[ 0.223954] io scheduler cfq registered (default)
[ 0.224073] keystone_irq soc:keystone_irq@26202a0: irqchip registered, nr_irqs 28
[ 0.225120] PCI host bridge /soc/pcie@21020000 ranges:
[ 0.225129] No bus range found for /soc/pcie@21020000, using [bus 00-ff]
[ 0.225144] MEM 0x60000000..0x6fffffff -> 0x60000000
[ 0.424885] keystone-pcie 21021000.pcie: phy link never came up
[ 0.425093] keystone-pcie 21021000.pcie: PCI host bridge to bus 0000:00
[ 0.425104] pci_bus 0000:00: root bus resource [bus 00-ff]
[ 0.425113] pci_bus 0000:00: root bus resource [mem 0x60000000-0x6fffffff]
[ 0.425412] PCI: bus0: Fast back to back transfers disabled
[ 0.425543] PCI: bus1: Fast back to back transfers enabled
[ 0.425599] pci 0000:00:00.0: PCI bridge to [bus 01]
[ 0.425818] pcieport 0000:00:00.0: Signaling PME through PCIe PME interrupt
[ 0.426164] keystone-navigator-qmss soc:qmss@2a40000: qmgr start queue 0, number of queues 8192
[ 0.426275] keystone-navigator-qmss soc:qmss@2a40000: added qmgr start queue 0, num of queues 8192, reg_peek f0b80000, reg_status f0b44000, reg_config f0b46000, reg_region f0b48000, reg_push f0bc0000, reg_pop f0c00000
[ 0.426403] keystone-navigator-qmss soc:qmss@2a40000: firmware file ks2_qmss_pdsp_acc48.bin downloaded for PDSP
[ 0.428119] keystone-navigator-dma soc:knav_dmas@0: DMA dma_gbe registered 149 logical channels, flows 128, tx chans: 21, rx chans: 91
[ 0.428223] keystone-navigator-dma soc:knav_dmas@0: DMA dma_xgbe registered 48 logical channels, flows 32, tx chans: 16, rx chans: 16
[ 0.489081] Serial: 8250/16550 driver, 4 ports, IRQ sharing disabled
[ 0.489160] platform serial8250: set dma_pfn_offset00780000
[ 0.490730] console [ttyS0] disabled
[ 0.490771] 2530c00.serial: ttyS0 at MMIO 0x2530c00 (irq = 26, base_baud = 13020833) is a 16550A
[ 1.321598] console [ttyS0] enabled
[ 1.325772] 2531000.serial: ttyS1 at MMIO 0x2531000 (irq = 27, base_baud = 13020833) is a 16550A
[ 1.339912] loop: module loaded
[ 1.343216] at24 0-0050: 131072 byte 24c1024 EEPROM, writable, 1 bytes/write
[ 1.351244] spi_davinci 21000400.spi: DMA is not supported (-19)
[ 1.357916] m25p80 spi32766.0: unrecognized JEDEC id bytes: 00, 0, 0
[ 1.364449] spi_davinci 21000400.spi: Controller at 0xf0b70400
[ 1.370433] spi_davinci 21000600.spi: DMA is not supported (-19)
[ 1.376799] spi_davinci 21000600.spi: Controller at 0xf0b72600
[ 1.382745] spi_davinci 21000800.spi: DMA is not supported (-19)
[ 1.389098] spi_davinci 21000800.spi: Controller at 0xf0b74800
[ 1.444897] davinci_mdio 24200f00.mdio: davinci mdio revision 1.7
[ 1.450983] libphy: 24200f00.mdio: probed
[ 1.455313] davinci_mdio 24200f00.mdio: phy[0]: device 24200f00.mdio:00, driver Marvell 88E1510
[ 4.476409] netcp-1.0 2620110.netcp: initialized cpsw ale version 1.4
[ 4.482843] netcp-1.0 2620110.netcp: ALE Table size 8192
[ 4.489358] netcp-1.0 2620110.netcp: module(netcp-xgbe) not used for device
[ 4.697598] platform xhci-hcd.0.auto: set dma_pfn_offset00780000
[ 4.904435] platform xhci-hcd.1.auto: set dma_pfn_offset00780000
[ 4.911023] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[ 4.916695] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 1
[ 4.924583] xhci-hcd xhci-hcd.0.auto: hcc params 0x0298f06d hci version 0x100 quirks 0x00010010
[ 4.933315] xhci-hcd xhci-hcd.0.auto: irq 34, io mem 0x02690000
[ 4.939381] usb usb1: New USB device found, idVendor=1d6b, idProduct=0002
[ 4.946174] usb usb1: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 4.953387] usb usb1: Product: xHCI Host Controller
[ 4.958267] usb usb1: Manufacturer: Linux 4.4.34-02701-g988ab9c xhci-hcd
[ 4.964984] usb usb1: SerialNumber: xhci-hcd.0.auto
[ 4.970327] hub 1-0:1.0: USB hub found
[ 4.974091] hub 1-0:1.0: 1 port detected
[ 4.978293] xhci-hcd xhci-hcd.0.auto: xHCI Host Controller
[ 4.983925] xhci-hcd xhci-hcd.0.auto: new USB bus registered, assigned bus number 2
[ 4.991587] (NULL net_device): Link is Down
[ 4.991590] (NULL net_device): Link is Down
[ 4.991593] (NULL net_device): Link is Down
[ 4.991596] (NULL net_device): Link is Down
[ 4.991599] (NULL net_device): Link is Down
[ 4.991601] (NULL net_device): Link is Down
[ 5.016864] usb usb2: We don't know the algorithms for LPM for this host, disabling LPM.
[ 5.025054] usb usb2: New USB device found, idVendor=1d6b, idProduct=0003
[ 5.031835] usb usb2: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 5.039063] usb usb2: Product: xHCI Host Controller
[ 5.043932] usb usb2: Manufacturer: Linux 4.4.34-02701-g988ab9c xhci-hcd
[ 5.050663] usb usb2: SerialNumber: xhci-hcd.0.auto
[ 5.055993] hub 2-0:1.0: USB hub found
[ 5.059755] hub 2-0:1.0: 1 port detected
[ 5.063959] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[ 5.069611] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 3
[ 5.077532] xhci-hcd xhci-hcd.1.auto: hcc params 0x0298f06d hci version 0x100 quirks 0x00010010
[ 5.086243] xhci-hcd xhci-hcd.1.auto: irq 69, io mem 0x25010000
[ 5.092264] usb usb3: New USB device found, idVendor=1d6b, idProduct=0002
[ 5.099061] usb usb3: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 5.106286] usb usb3: Product: xHCI Host Controller
[ 5.111155] usb usb3: Manufacturer: Linux 4.4.34-02701-g988ab9c xhci-hcd
[ 5.117860] usb usb3: SerialNumber: xhci-hcd.1.auto
[ 5.123157] hub 3-0:1.0: USB hub found
[ 5.126934] hub 3-0:1.0: 1 port detected
[ 5.131099] xhci-hcd xhci-hcd.1.auto: xHCI Host Controller
[ 5.136747] xhci-hcd xhci-hcd.1.auto: new USB bus registered, assigned bus number 4
[ 5.144445] usb usb4: We don't know the algorithms for LPM for this host, disabling LPM.
[ 5.152632] usb usb4: New USB device found, idVendor=1d6b, idProduct=0003
[ 5.159510] usb usb4: New USB device strings: Mfr=3, Product=2, SerialNumber=1
[ 5.166737] usb usb4: Product: xHCI Host Controller
[ 5.171606] usb usb4: Manufacturer: Linux 4.4.34-02701-g988ab9c xhci-hcd
[ 5.178480] usb usb4: SerialNumber: xhci-hcd.1.auto
[ 5.183792] hub 4-0:1.0: USB hub found
[ 5.187570] hub 4-0:1.0: 1 port detected
[ 5.191953] usbcore: registered new interface driver usb-storage
[ 5.198261] mousedev: PS/2 mouse device common for all mice
[ 5.204070] i2c /dev entries driver
[ 5.208077] davinci-wdt 22f0080.wdt: heartbeat 60 sec
[ 5.214020] usbcore: registered new interface driver usbhid
[ 5.219601] usbhid: USB HID core driver
[ 5.224194] nand: device found, Manufacturer ID: 0x2c, Chip ID: 0xac
[ 5.230629] nand: Micron MT29F4G08ABBDAHC
[ 5.234633] nand: 512 MiB, SLC, erase size: 128 KiB, page size: 2048, OOB size: 64
[ 5.242554] Bad block table found at page 262080, version 0x01
[ 5.248905] Bad block table found at page 262016, version 0x01
[ 5.255066] 3 ofpart partitions found on MTD device 30000000.nand
[ 5.261149] Creating 3 MTD partitions on "30000000.nand":
[ 5.266553] 0x000000000000-0x000000100000 : "u-boot"
[ 5.272373] 0x000000100000-0x000000180000 : "params"
[ 5.278175] 0x000000180000-0x000020000000 : "ubifs"
[ 5.284123] davinci_nand 30000000.nand: controller rev. 2.5
[ 5.290148] platform oprofile-perf.0: set dma_pfn_offset00780000
[ 5.296177] usb 1-1: new high-speed USB device number 2 using xhci-hcd
[ 5.302992] oprofile: using timer interrupt.
[ 5.307397] Netfilter messages via NETLINK v0.30.
[ 5.312106] nf_conntrack version 0.5.0 (16384 buckets, 65536 max)
[ 5.318678] ctnetlink v0.93: registering with nfnetlink.
[ 5.324304] ipip: IPv4 over IPv4 tunneling driver
[ 5.329561] gre: GRE over IPv4 demultiplexor driver
[ 5.334434] ip_gre: GRE over IPv4 tunneling driver
[ 5.340280] ip_tables: (C) 2000-2006 Netfilter Core Team
[ 5.345763] ipt_CLUSTERIP: ClusterIP Version 0.8 loaded successfully
[ 5.352133] arp_tables: (C) 2002 David S. Miller
[ 5.356869] Initializing XFRM netlink socket
[ 5.362056] NET: Registered protocol family 10
[ 5.367343] NET: Registered protocol family 17
[ 5.371793] NET: Registered protocol family 15
[ 5.376255] 8021q: 802.1Q VLAN Support v1.8
[ 5.380479] sctp: Hash tables configured (established 512 bind 512)
[ 5.387148] Registering SWP/SWPB emulation handler
[ 5.393185] ubi0: attaching mtd2
[ 5.435168] usb 1-1: New USB device found, idVendor=0451, idProduct=8142
[ 5.441861] usb 1-1: New USB device strings: Mfr=0, Product=0, SerialNumber=1
[ 5.464886] usb 1-1: SerialNumber: BD0B00599C0C
[ 5.497217] hub 1-1:1.0: USB hub found
[ 5.501040] hub 1-1:1.0: 4 ports detected
[ 7.517651] ubi0: scanning is finished
[ 7.532044] ubi0: attached mtd2 (name "ubifs", size 510 MiB)
[ 7.537708] ubi0: PEB size: 131072 bytes (128 KiB), LEB size: 126976 bytes
[ 7.544574] ubi0: min./max. I/O unit sizes: 2048/2048, sub-page size 2048
[ 7.551364] ubi0: VID header offset: 2048 (aligned 2048), data offset: 4096
[ 7.558325] ubi0: good PEBs: 4080, bad PEBs: 4, corrupted PEBs: 0
[ 7.564409] ubi0: user volume: 1, internal volumes: 1, max. volumes count: 128
[ 7.571629] ubi0: max/mean erase counter: 3/0, WL threshold: 4096, image sequence number: 1710674976
[ 7.580761] ubi0: available PEBs: 0, total reserved PEBs: 4080, PEBs reserved for bad PEB handling: 76
[ 7.590073] ubi0: background thread "ubi_bgt0d" started, PID 1180
[ 7.602839] UBIFS: parse sync
[ 7.606445] UBIFS (ubi0:0): background thread "ubifs_bgt0_0" started, PID 1182
[ 7.676507] UBIFS (ubi0:0): UBIFS: mounted UBI device 0, volume 0, name "rootfs"
[ 7.683895] UBIFS (ubi0:0): LEB size: 126976 bytes (124 KiB), min./max. I/O unit sizes: 2048 bytes/2048 bytes
[ 7.693809] UBIFS (ubi0:0): FS size: 488222720 bytes (465 MiB, 3845 LEBs), journal size 9023488 bytes (8 MiB, 72 LEBs)
[ 7.704505] UBIFS (ubi0:0): reserved for root: 0 bytes (0 KiB)
[ 7.710338] UBIFS (ubi0:0): media format: w4/r0 (latest is w4/r0), UUID 02D63BE4-8E77-4DC6-AEE2-4121E543AF4F, small LPT model
[ 7.723497] VFS: Mounted root (ubifs filesystem) on device 0:15.
[ 7.731099] devtmpfs: mounted
[ 7.734232] Freeing unused kernel memory: 360K (c0790000 - c07ea000)
[ 7.939110] systemd[1]: System time before build time, advancing clock.
[ 7.984545] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.013458] systemd[1]: systemd 229 running in system mode. (+PAM -AUDIT -SELINUX +IMA -APPARMOR +SMACK +SYSVINIT +UTMP -LIBCRYPTSETUP -GCRYPT -GNUTLS +ACL +XZ -LZ4 -SECCOMP +BLKID -ELFUTILS +KMOD -IDN)
[ 8.032325] systemd[1]: Detected architecture arm.
Welcome to [1mArago 2016.08[0m!
[ 8.056875] systemd[1]: Set hostname to <k2e-evm>.
[ 8.124663] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.193849] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.225262] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.250783] random: systemd-sysv-ge: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.323284] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.332547] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.397501] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.406877] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.416466] random: systemd: uninitialized urandom read (16 bytes read, 0 bits of entropy available)
[ 8.560394] systemd[1]: [/lib/systemd/system/syslog-ng.service:6] Executable path is not absolute, ignoring: @SBINDIR@/syslog-ng -F -p @LOCALSTATEDIR@/run/syslogd.pid
[ 8.575331] systemd[1]: [/lib/systemd/system/syslog-ng.service:7] Executable path is not absolute, ignoring: @BASEBINDIR@/kill -HUP $MAINPID
[ 8.588203] systemd[1]: syslog-ng.service: Service lacks both ExecStart= and ExecStop= setting. Refusing.
[ 8.688380] systemd[1]: syslog-ng.service: Cannot add dependency job, ignoring: Unit syslog-ng.service is not loaded properly: Invalid argument.
[ 8.707452] systemd[1]: syslog.socket: Socket service syslog-ng.service not loaded, refusing.
[ 8.716023] systemd[1]: Failed to listen on Syslog Socket.
[[0;1;31mFAILED[0m] Failed to listen on Syslog Socket.
See 'systemctl status syslog.socket' for details.
[ 8.767270] systemd[1]: Listening on /dev/initctl Compatibility Named Pipe.
[[0;32m OK [0m] Listening on /dev/initctl Compatibility Named Pipe.
[ 8.795052] systemd[1]: Listening on udev Control Socket.
[[0;32m OK [0m] Listening on udev Control Socket.
[ 8.825012] systemd[1]: Listening on udev Kernel Socket.
[[0;32m OK [0m] Listening on udev Kernel Socket.
[ 8.846649] systemd[1]: Created slice User and Session Slice.
[[0;32m OK [0m] Created slice User and Session Slice.
[ 8.875669] systemd[1]: Started Dispatch Password Requests to Console Directory Watch.
[[0;32m OK [0m] Started Dispatch Password Requests to Console Directory Watch.
[ 8.905080] systemd[1]: Started Forward Password Requests to Wall Directory Watch.
[[0;32m OK [0m] Started Forward Password Requests to Wall Directory Watch.
[ 8.935122] systemd[1]: Listening on Network Service Netlink Socket.
[[0;32m OK [0m] Listening on Network Service Netlink Socket.
[ 8.965080] systemd[1]: Listening on Journal Socket.
[[0;32m OK [0m] Listening on Journal Socket.
[ 8.985128] systemd[1]: Reached target Paths.
[[0;32m OK [0m] Reached target Paths.
[ 9.022976] systemd[1]: Created slice System Slice.
[[0;32m OK [0m] Created slice System Slice.
[ 9.045404] systemd[1]: Created slice system-serial\x2dgetty.slice.
[[0;32m OK [0m] Created slice system-serial\x2dgetty.slice.
[ 9.074964] systemd[1]: Reached target Slices.
[[0;32m OK [0m] Reached target Slices.
[ 9.125043] systemd[1]: Mounting POSIX Message Queue File System...
Mounting POSIX Message Queue File System...
[ 9.163171] systemd[1]: Starting Setup Virtual Console...
Starting Setup Virtual Console...
[ 9.186418] systemd[1]: Mounting Debug File System...
Mounting Debug File System...
[ 9.207491] systemd[1]: Mounting Temporary Directory...
Mounting Temporary Directory...
[ 9.234994] systemd[1]: Reached target Remote File Systems.
[[0;32m OK [0m] Reached target Remote File Systems.
[ 9.265004] systemd[1]: Reached target Swap.
[[0;32m OK [0m] Reached target Swap.
[ 9.285375] systemd[1]: Created slice system-getty.slice.
[[0;32m OK [0m] Created slice system-getty.slice.
[ 9.355176] systemd[1]: Starting Remount Root and Kernel File Systems...
Starting Remount Root and Kernel File Systems...
[ 9.380448] systemd[1]: Starting Load Kernel Modules...
Starting Load Kernel Modules...
[ 9.405120] systemd[1]: Listening on Journal Socket (/dev/log).
[[0;32m OK [0m] Listening on Journal Socket (/dev/log).
[ 9.475186] systemd[1]: Starting Journal Service...
Starting Journal Service...
[ 9.498124] systemd[1]: Starting Create Static Device Nodes in /dev...
Starting Create Static Device Nodes in /dev...
[ 9.533100] systemd[1]: Mounted Debug File System.
[[0;32m OK [0m] Mounted Debug File System.
[ 9.555107] systemd[1]: Mounted POSIX Message Queue File System.
[[0;32m OK [0m] Mounted POSIX Message Queue File System.
[ 9.585143] systemd[1]: Mounted Temporary Directory.
[[0;32m OK [0m] Mounted Temporary Directory.
[ 9.615912] systemd[1]: Started Setup Virtual Console.
[[0;32m OK [0m] Started Setup Virtual Console.
[ 9.647496] systemd[1]: Started Remount Root and Kernel File Systems.
[[0;32m OK [0m] Started Remount Root and Kernel File Systems.
[ 9.675201] systemd[1]: systemd-modules-load.service: Main process exited, code=exited, status=1/FAILURE
[ 9.685469] systemd[1]: Failed to start Load Kernel Modules.
[[0;1;31mFAILED[0m] Failed to start Load Kernel Modules.
See 'systemctl status systemd-modules-load.service' for details.
[ 9.734952] systemd[1]: systemd-modules-load.service: Unit entered failed state.
[ 9.742351] systemd[1]: systemd-modules-load.service: Failed with result 'exit-code'.
[ 9.751813] systemd[1]: Started Create Static Device Nodes in /dev.
[[0;32m OK [0m] Started Create Static Device Nodes in /dev.
[ 9.775342] systemd[1]: Started Journal Service.
[[0;32m OK [0m] Started Journal Service.
Starting udev Kernel Device Manager...
Starting Apply Kernel Variables...
Starting udev Coldplug all Devices...
Starting Flush Journal to Persistent Storage...
[[0;32m OK [0m] Reached target Local File Systems (Pre).
Mounting /var/volatile...
Mounting /media/ram...
[[0;32m OK [0m] Mounted /var/volatile.
[[0;32m OK [0m] Mounted /media/ram.
[[0;32m OK [0m] Started udev Kernel Device Manager.
[[0;32m OK [0m] Started Apply Kernel Variables.
[ 10.386941] systemd-journald[1218]: Received request to flush runtime journal from PID 1
[[0;32m OK [0m] Started Flush Journal to Persistent Storage.
Starting Load/Save Random Seed...
[[0;32m OK [0m] Reached target Local File Systems.
Starting Create Volatile Files and Directories...
[[0;32m OK [0m] Started Load/Save Random Seed.
[[0;32m OK [0m] Started udev Coldplug all Devices.
[[0;32m OK [0m] Started Create Volatile Files and Directories.
[[0;32m OK [0m] Found device /dev/ttyS0.
Starting Update UTMP about System Boot/Shutdown...
Starting Network Time Synchronization...
[[0;32m OK [0m] Started Update UTMP about System Boot/Shutdown.
[[0;32m OK [0m] Started Network Time Synchronization.
[[0;32m OK [0m] Reached target System Time Synchronized.
Starting Synchronize System and HW clocks...
[[0;1;31mFAILED[0m] Failed to start Synchronize System and HW clocks.
See 'systemctl status sync-clocks.service' for details.
[[0;32m OK [0m] Reached target System Initialization.
[[0;32m OK [0m] Listening on D-Bus System Message Bus Socket.
[[0;32m OK [0m] Listening on RPCbind Server Activation Socket.
[[0;32m OK [0m] Listening on dropbear.socket.
[[0;32m OK [0m] Reached target Sockets.
[[0;32m OK [0m] Reached target Basic System.
Starting Permit User Sessions...
Starting Login Service...
Starting softhsm-daemon.service...
[[0;32m OK [0m] Started System Logging Service.
Starting Print notice about GPLv3 packages...
Starting telnetd.service...
[[0;32m OK [0m] Started Kernel Logging Service.
Starting Ethernet Bridge Filtering Tables...
[[0;32m OK [0m] Started strongSwan IPsec IKEv1/IKEv2 daemon using ipsec.conf.
Starting run_srss_tc.service...
Starting tiipclad-daemon.service...
[[0;32m OK [0m] Started Daily Cleanup of Temporary Directories.
[[0;32m OK [0m] Reached target Timers.
[[0;32m OK [0m] Started D-Bus System Message Bus.
Starting Network Service...
Starting TI Multiproc Manager...
[[0;32m OK [0m] Started Permit User Sessions.
[[0;32m OK [0m] Started telnetd.service.
[[0;32m OK [0m] Started Ethernet Bridge Filtering Tables.
[[0;32m OK [0m] Started run_srss_tc.service.
[[0;32m OK [0m] Started tiipclad-daemon.service.
[[0;1;31mFAILED[0m] Failed to start TI Multiproc Manager.
See 'systemctl status mpmsrv-daemon.service' for details.
ipsec_starter[2341]: Starting strongSwan 5.3.2 IPsec [starter]...
[[0;32m OK [0m] Started Getty on tty1.
[[0;32m OK [0m] Started Serial Getty on ttyS0.
[[0;32m OK [0m] Started Login Service.
[[0;32m OK [0m] Started Network Service.
[[0;32m OK [0m] Reached target Network.
Starting Lightning Fast Webserver With Light System Requirements...
Starting Network Name Resolution...
[[0;32m OK [0m] Started Vsftpd ftp daemon.
[[0;32m OK [0m] Started softhsm-daemon.service.
Starting thttpd.service...
[ 13.500842] netcp-1.0 2620110.netcp eth1: Link is Up
[ 13.532597] 8021q: adding VLAN 0 to HW filter on device eth1
[ 13.556869] netcp-1.0 2620110.netcp eth0: Link is Up - 1Gbps/Full - flow control off
[ 13.573904] IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready
[ 13.579837] 8021q: adding VLAN 0 to HW filter on device eth0
[[0;32m OK [0m] Started thttpd.service.
Starting rng-tools.service...
[[0;32m OK [0m] Started Lightning Fast Webserver With Light System Requirements.
[[0;32m OK [0m] Started rng-tools.service.
Starting gdbserverproxy.service...
[[0;32m OK [0m] Started gdbserverproxy.service.
[[0;32m OK [0m] Started Network Name Resolution.
Starting matrix-gui-2.0.service...
[[0;32m OK [0m] Started matrix-gui-2.0.service.
Starting thermal-zone-init.service...
Starting parse-ip.service...
[[0;32m OK [0m] Started thermal-zone-init.service.
ipsec_starter[2341]: charon (2409) started after 620 ms
***************************************************************
***************************************************************
NOTICE: This file system contains the following GPLv3 packages:
autoconf
binutils
cpp-symlinks
cpp
dosfstools
g++-symlinks
g++
gawk
gcc-symlinks
gcc
gdb
gdbc6x
gdbserver
libgmp10
libmpc3
libmpfr4
make
If you do not wish to distribute GPLv3 components please remove
the above packages prior to distribution. This can be done using
the opkg remove command. i.e.:
opkg remove <package>
Where <package> is the name printed in the list above
NOTE: If the package is a dependency of another package you
will be notified of the dependent packages. You should
use the --force-removal-of-dependent-packages option to
also remove the dependent packages as well
***************************************************************
***************************************************************
[[0;32m OK [0m] Started Print notice about GPLv3 packages.
[ 14.984898] netcp-1.0 2620110.netcp eth0: Link is Down
#>>>>> LCD 12
IP Address:
[[0;32m OK [0m] Started parse-ip.service.
[ 18.555241] netcp-1.0 2620110.netcp eth0: Link is Up - 1Gbps/Full - flow control off
[ 18.562989] IPv6: ADDRCONF(NETDEV_CHANGE): eth0: link becomes ready
_____ _____ _ _
| _ |___ ___ ___ ___ | _ |___ ___ |_|___ ___| |_
| | _| .'| . | . | | __| _| . | | | -_| _| _|
|__|__|_| |__,|_ |___| |__| |_| |___|_| |___|___|_|
|___| |___|
Arago Project http://arago-project.org k2e-evm ttyS0
Arago 2016.08 k2e-evm ttyS0
k2e-evm login:
Nevertheless, I compiled linuxptp and tried with software timestamping. It seems to somehow work but I am not sure about the timeout message:
Software Timestamping with ptp4l: -------------------------------- Master: root@k2e-evm:~# ./ptp4l -E -2 -S -i eth0 -l 7 -m -q ptp4l[1169.892]: config item (null).assume_two_step is 0 ptp4l[1169.892]: config item (null).check_fup_sync is 0 ptp4l[1169.892]: config item (null).tx_timestamp_timeout is 1 ptp4l[1169.892]: config item (null).clock_servo is 0 ptp4l[1169.892]: config item (null).time_stamping is 0 ptp4l[1169.892]: config item (null).clock_servo is 0 ptp4l[1169.892]: config item (null).clockClass is 248 ptp4l[1169.892]: config item (null).clockAccuracy is 254 ptp4l[1169.892]: config item (null).offsetScaledLogVariance is 65535 ptp4l[1169.892]: config item (null).productDescription is ';;' ptp4l[1169.892]: config item (null).revisionData is ';;' ptp4l[1169.892]: config item (null).userDescription is '' ptp4l[1169.892]: config item (null).manufacturerIdentity is '00:00:00' ptp4l[1169.892]: config item (null).domainNumber is 0 ptp4l[1169.892]: config item (null).slaveOnly is 0 ptp4l[1169.892]: config item (null).twoStepFlag is 1 ptp4l[1169.892]: config item (null).priority1 is 128 ptp4l[1169.892]: config item (null).priority2 is 128 ptp4l[1169.892]: config item (null).gmCapable is 1 ptp4l[1169.892]: config item (null).gmCapable is 1 ptp4l[1169.892]: config item (null).free_running is 0 ptp4l[1169.892]: config item (null).uds_address is '/var/run/ptp4l' ptp4l[1169.892]: section item /var/run/ptp4l.announceReceiptTimeout now 0 ptp4l[1169.892]: section item /var/run/ptp4l.delay_mechanism now 0 ptp4l[1169.892]: section item /var/run/ptp4l.network_transport now 0 ptp4l[1169.892]: section item /var/run/ptp4l.delay_filter_length now 1 ptp4l[1169.892]: config item (null).free_running is 0 ptp4l[1169.892]: config item (null).freq_est_interval is 1 ptp4l[1169.892]: config item (null).gmCapable is 1 ptp4l[1169.892]: config item (null).kernel_leap is 1 ptp4l[1169.892]: config item (null).timeSource is 160 ptp4l[1169.892]: config item (null).pi_proportional_const is 0.000000 ptp4l[1169.892]: config item (null).pi_integral_const is 0.000000 ptp4l[1169.892]: config item (null).pi_proportional_scale is 0.000000 ptp4l[1169.892]: config item (null).pi_proportional_exponent is -0.300000 ptp4l[1169.892]: config item (null).pi_proportional_norm_max is 0.700000 ptp4l[1169.892]: config item (null).pi_integral_scale is 0.000000 ptp4l[1169.892]: config item (null).pi_integral_exponent is 0.400000 ptp4l[1169.893]: config item (null).pi_integral_norm_max is 0.300000 ptp4l[1169.893]: config item (null).step_threshold is 0.000000 ptp4l[1169.893]: config item (null).first_step_threshold is 0.000020 ptp4l[1169.893]: config item (null).max_frequency is 900000000 ptp4l[1169.893]: config item (null).tsproc_mode is 0 ptp4l[1169.893]: config item (null).delay_filter is 1 ptp4l[1169.893]: config item (null).delay_filter_length is 10 ptp4l[1169.893]: config item (null).summary_interval is 0 ptp4l[1169.893]: config item (null).sanity_freq_limit is 200000000 ptp4l[1169.893]: PI servo: sync interval 1.000 kp 0.100 ki 0.001000 ptp4l[1169.893]: config item /var/run/ptp4l.boundary_clock_jbod is 0 ptp4l[1169.893]: config item /var/run/ptp4l.network_transport is 0 ptp4l[1169.893]: config item /var/run/ptp4l.delayAsymmetry is 0 ptp4l[1169.893]: config item /var/run/ptp4l.follow_up_info is 0 ptp4l[1169.893]: config item /var/run/ptp4l.freq_est_interval is 1 ptp4l[1169.893]: config item /var/run/ptp4l.hybrid_e2e is 0 ptp4l[1169.893]: config item /var/run/ptp4l.path_trace_enabled is 0 ptp4l[1169.893]: config item /var/run/ptp4l.ingressLatency is 0 ptp4l[1169.893]: config item /var/run/ptp4l.egressLatency is 0 ptp4l[1169.893]: config item /var/run/ptp4l.delay_mechanism is 0 ptp4l[1169.893]: config item /var/run/ptp4l.fault_badpeernet_interval is 16 ptp4l[1169.893]: config item /var/run/ptp4l.fault_reset_interval is 4 ptp4l[1169.893]: config item /var/run/ptp4l.tsproc_mode is 0 ptp4l[1169.893]: config item /var/run/ptp4l.delay_filter is 1 ptp4l[1169.893]: config item /var/run/ptp4l.delay_filter_length is 1 ptp4l[1169.893]: config item eth0.boundary_clock_jbod is 0 ptp4l[1169.893]: config item eth0.network_transport is 3 ptp4l[1169.893]: config item eth0.delayAsymmetry is 0 ptp4l[1170.225]: config item eth0.follow_up_info is 0 ptp4l[1170.225]: config item eth0.freq_est_interval is 1 ptp4l[1170.225]: config item eth0.hybrid_e2e is 0 ptp4l[1170.225]: config item eth0.path_trace_enabled is 0 ptp4l[1170.225]: config item eth0.ingressLatency is 0 ptp4l[1170.225]: config item eth0.egressLatency is 0 ptp4l[1170.225]: config item eth0.delay_mechanism is 1 ptp4l[1170.225]: config item eth0.fault_badpeernet_interval is 16 ptp4l[1170.225]: config item eth0.fault_reset_interval is 4 ptp4l[1170.225]: config item eth0.tsproc_mode is 0 ptp4l[1170.225]: config item eth0.delay_filter is 1 ptp4l[1170.225]: config item eth0.delay_filter_length is 10 ptp4l[1170.225]: config item eth0.logMinDelayReqInterval is 0 ptp4l[1170.225]: config item eth0.logAnnounceInterval is 1 ptp4l[1170.225]: config item eth0.announceReceiptTimeout is 3 ptp4l[1170.225]: config item eth0.syncReceiptTimeout is 0 ptp4l[1170.225]: config item eth0.transportSpecific is 0 ptp4l[1170.225]: config item eth0.logSyncInterval is 0 ptp4l[1170.225]: config item eth0.logMinPdelayReqInterval is 0 ptp4l[1170.225]: config item eth0.neighborPropDelayThresh is 20000000 ptp4l[1170.225]: config item eth0.min_neighbor_prop_delay is -20000000 ptp4l[1170.225]: config item eth0.ptp_dst_mac is '01:1B:19:00:00:00' ptp4l[1170.225]: config item eth0.p2p_dst_mac is '01:80:C2:00:00:0E' ptp4l[1170.290]: port 1: INITIALIZING to LISTENING on INITIALIZE ptp4l[1170.290]: config item /var/run/ptp4l.logMinDelayReqInterval is 0 ptp4l[1170.290]: config item /var/run/ptp4l.logAnnounceInterval is 1 ptp4l[1170.290]: config item /var/run/ptp4l.announceReceiptTimeout is 0 ptp4l[1170.290]: config item /var/run/ptp4l.syncReceiptTimeout is 0 ptp4l[1170.290]: config item /var/run/ptp4l.transportSpecific is 0 ptp4l[1170.290]: config item /var/run/ptp4l.logSyncInterval is 0 ptp4l[1170.290]: config item /var/run/ptp4l.logMinPdelayReqInterval is 0 ptp4l[1170.290]: config item /var/run/ptp4l.neighborPropDelayThresh is 20000000 ptp4l[1170.290]: config item /var/run/ptp4l.min_neighbor_prop_delay is -20000000 ptp4l[1170.290]: config item (null).uds_address is '/var/run/ptp4l' ptp4l[1170.290]: port 0: INITIALIZING to LISTENING on INITIALIZE ptp4l[1170.290]: interface index 1 is up ptp4l[1170.290]: interface index 2 is up ptp4l[1170.290]: port 1: link up ptp4l[1170.290]: interface index 3 is up ptp4l[1170.290]: interface index 4 is down ptp4l[1170.290]: interface index 5 is down ptp4l[1170.290]: interface index 6 is down ptp4l[1176.662]: port 1: announce timeout ptp4l[1176.662]: port 1: LISTENING to MASTER on ANNOUNCE_RECEIPT_TIMEOUT_EXPIRES ptp4l[1176.662]: selected best master clock 080028.fffe.32adda ptp4l[1176.662]: assuming the grand master role ptp4l[1176.663]: port 1: master tx announce timeout ptp4l[1176.663]: port 1: setting asCapable ptp4l[1177.662]: port 1: master sync timeout ptp4l[1178.662]: port 1: master sync timeout ptp4l[1178.663]: port 1: master tx announce timeout ptp4l[1179.662]: port 1: master sync timeout ptp4l[1180.566]: port 1: new foreign master 1662e1.fffe.116d6a-1 ptp4l[1180.662]: port 1: master sync timeout ptp4l[1180.663]: port 1: master tx announce timeout ptp4l[1181.662]: port 1: master sync timeout ptp4l[1182.662]: port 1: master sync timeout ptp4l[1182.663]: port 1: master tx announce timeout ptp4l[1183.662]: port 1: master sync timeout ptp4l[1184.662]: port 1: master sync timeout ptp4l[1184.663]: port 1: master tx announce timeout ptp4l[1185.662]: port 1: master sync timeout ptp4l[1186.662]: port 1: master sync timeout ptp4l[1186.663]: port 1: master tx announce timeout ptp4l[1187.662]: port 1: master sync timeout ptp4l[1188.662]: port 1: master sync timeout ptp4l[1188.663]: port 1: master tx announce timeout ptp4l[1189.662]: port 1: master sync timeout ptp4l[1190.662]: port 1: master sync timeout ptp4l[1190.663]: port 1: master tx announce timeout ptp4l[1191.662]: port 1: master sync timeout ptp4l[1192.662]: port 1: master sync timeout ptp4l[1192.663]: port 1: master tx announce timeout ptp4l[1193.662]: port 1: master sync timeout Slave: root@k2e-evm:~# ./ptp4l -E -2 -S -i eth3 -l 7 -m -q ptp4l[350.532]: config item (null).assume_two_step is 0 ptp4l[350.532]: config item (null).check_fup_sync is 0 ptp4l[350.532]: config item (null).tx_timestamp_timeout is 1 ptp4l[350.532]: config item (null).clock_servo is 0 ptp4l[350.532]: config item (null).time_stamping is 0 ptp4l[350.532]: config item (null).clock_servo is 0 ptp4l[350.532]: config item (null).clockClass is 248 ptp4l[350.532]: config item (null).clockAccuracy is 254 ptp4l[350.532]: config item (null).offsetScaledLogVariance is 65535 ptp4l[350.532]: config item (null).productDescription is ';;' ptp4l[350.532]: config item (null).revisionData is ';;' ptp4l[350.532]: config item (null).userDescription is '' ptp4l[350.532]: config item (null).manufacturerIdentity is '00:00:00' ptp4l[350.532]: config item (null).domainNumber is 0 ptp4l[350.532]: config item (null).slaveOnly is 0 ptp4l[350.532]: config item (null).twoStepFlag is 1 ptp4l[350.532]: config item (null).priority1 is 128 ptp4l[350.532]: config item (null).priority2 is 128 ptp4l[350.532]: config item (null).gmCapable is 1 ptp4l[350.532]: config item (null).gmCapable is 1 ptp4l[350.532]: config item (null).free_running is 0 ptp4l[350.532]: config item (null).uds_address is '/var/run/ptp4l' ptp4l[350.532]: section item /var/run/ptp4l.announceReceiptTimeout now 0 ptp4l[350.532]: section item /var/run/ptp4l.delay_mechanism now 0 ptp4l[350.532]: section item /var/run/ptp4l.network_transport now 0 ptp4l[350.532]: section item /var/run/ptp4l.delay_filter_length now 1 ptp4l[350.532]: config item (null).free_running is 0 ptp4l[350.532]: config item (null).freq_est_interval is 1 ptp4l[350.532]: config item (null).gmCapable is 1 ptp4l[350.532]: config item (null).kernel_leap is 1 ptp4l[350.532]: config item (null).timeSource is 160 ptp4l[350.532]: config item (null).pi_proportional_const is 0.000000 ptp4l[350.532]: config item (null).pi_integral_const is 0.000000 ptp4l[350.532]: config item (null).pi_proportional_scale is 0.000000 ptp4l[350.532]: config item (null).pi_proportional_exponent is -0.300000 ptp4l[350.532]: config item (null).pi_proportional_norm_max is 0.700000 ptp4l[350.532]: config item (null).pi_integral_scale is 0.000000 ptp4l[350.532]: config item (null).pi_integral_exponent is 0.400000 ptp4l[350.532]: config item (null).pi_integral_norm_max is 0.300000 ptp4l[350.532]: config item (null).step_threshold is 0.000000 ptp4l[350.532]: config item (null).first_step_threshold is 0.000020 ptp4l[350.532]: config item (null).max_frequency is 900000000 ptp4l[350.532]: config item (null).tsproc_mode is 0 ptp4l[350.532]: config item (null).delay_filter is 1 ptp4l[350.533]: config item (null).delay_filter_length is 10 ptp4l[350.533]: config item (null).summary_interval is 0 ptp4l[350.533]: config item (null).sanity_freq_limit is 200000000 ptp4l[350.533]: PI servo: sync interval 1.000 kp 0.100 ki 0.001000 ptp4l[350.533]: config item /var/run/ptp4l.boundary_clock_jbod is 0 ptp4l[350.533]: config item /var/run/ptp4l.network_transport is 0 ptp4l[350.533]: config item /var/run/ptp4l.delayAsymmetry is 0 ptp4l[350.533]: config item /var/run/ptp4l.follow_up_info is 0 ptp4l[350.533]: config item /var/run/ptp4l.freq_est_interval is 1 ptp4l[350.533]: config item /var/run/ptp4l.hybrid_e2e is 0 ptp4l[350.533]: config item /var/run/ptp4l.path_trace_enabled is 0 ptp4l[350.533]: config item /var/run/ptp4l.ingressLatency is 0 ptp4l[350.533]: config item /var/run/ptp4l.egressLatency is 0 ptp4l[350.533]: config item /var/run/ptp4l.delay_mechanism is 0 ptp4l[350.533]: config item /var/run/ptp4l.fault_badpeernet_interval is 16 ptp4l[350.533]: config item /var/run/ptp4l.fault_reset_interval is 4 ptp4l[350.533]: config item /var/run/ptp4l.tsproc_mode is 0 ptp4l[350.533]: config item /var/run/ptp4l.delay_filter is 1 ptp4l[350.533]: config item /var/run/ptp4l.delay_filter_length is 1 ptp4l[350.533]: config item eth3.boundary_clock_jbod is 0 ptp4l[350.533]: config item eth3.network_transport is 3 ptp4l[350.533]: config item eth3.delayAsymmetry is 0 ptp4l[350.533]: config item eth3.follow_up_info is 0 ptp4l[350.865]: config item eth3.freq_est_interval is 1 ptp4l[350.865]: config item eth3.hybrid_e2e is 0 ptp4l[350.865]: config item eth3.path_trace_enabled is 0 ptp4l[350.865]: config item eth3.ingressLatency is 0 ptp4l[350.865]: config item eth3.egressLatency is 0 ptp4l[350.865]: config item eth3.delay_mechanism is 1 ptp4l[350.865]: config item eth3.fault_badpeernet_interval is 16 ptp4l[350.865]: config item eth3.fault_reset_interval is 4 ptp4l[350.865]: config item eth3.tsproc_mode is 0 ptp4l[350.865]: config item eth3.delay_filter is 1 ptp4l[350.865]: config item eth3.delay_filter_length is 10 ptp4l[350.865]: config item eth3.logMinDelayReqInterval is 0 ptp4l[350.865]: config item eth3.logAnnounceInterval is 1 ptp4l[350.865]: config item eth3.announceReceiptTimeout is 3 ptp4l[350.865]: config item eth3.syncReceiptTimeout is 0 ptp4l[350.865]: config item eth3.transportSpecific is 0 ptp4l[350.865]: config item eth3.logSyncInterval is 0 ptp4l[350.865]: config item eth3.logMinPdelayReqInterval is 0 ptp4l[350.865]: config item eth3.neighborPropDelayThresh is 20000000 ptp4l[350.865]: config item eth3.min_neighbor_prop_delay is -20000000 ptp4l[350.865]: config item eth3.ptp_dst_mac is '01:1B:19:00:00:00' ptp4l[350.865]: config item eth3.p2p_dst_mac is '01:80:C2:00:00:0E' ptp4l[350.930]: port 1: INITIALIZING to LISTENING on INITIALIZE ptp4l[350.930]: config item /var/run/ptp4l.logMinDelayReqInterval is 0 ptp4l[350.930]: config item /var/run/ptp4l.logAnnounceInterval is 1 ptp4l[350.930]: config item /var/run/ptp4l.announceReceiptTimeout is 0 ptp4l[350.930]: config item /var/run/ptp4l.syncReceiptTimeout is 0 ptp4l[350.930]: config item /var/run/ptp4l.transportSpecific is 0 ptp4l[350.930]: config item /var/run/ptp4l.logSyncInterval is 0 ptp4l[350.930]: config item /var/run/ptp4l.logMinPdelayReqInterval is 0 ptp4l[350.930]: config item /var/run/ptp4l.neighborPropDelayThresh is 20000000 ptp4l[350.930]: config item /var/run/ptp4l.min_neighbor_prop_delay is -20000000 ptp4l[350.930]: config item (null).uds_address is '/var/run/ptp4l' ptp4l[350.930]: port 0: INITIALIZING to LISTENING on INITIALIZE ptp4l[350.930]: interface index 1 is up ptp4l[350.930]: interface index 2 is up ptp4l[350.930]: interface index 3 is down ptp4l[350.930]: interface index 4 is down ptp4l[350.930]: interface index 5 is up ptp4l[350.930]: port 1: link up ptp4l[350.930]: interface index 6 is up ptp4l[350.930]: interface index 7 is down ptp4l[350.930]: interface index 8 is down ptp4l[350.930]: interface index 9 is down ptp4l[354.116]: port 1: setting asCapable ptp4l[354.116]: port 1: new foreign master 080028.fffe.32adda-1 ptp4l[358.019]: port 1: announce timeout ptp4l[358.019]: port 1: LISTENING to MASTER on ANNOUNCE_RECEIPT_TIMEOUT_EXPIRES ptp4l[358.019]: selected best master clock 1662e1.fffe.116d6a ptp4l[358.019]: assuming the grand master role ptp4l[358.020]: port 1: master tx announce timeout ptp4l[358.116]: selected best master clock 080028.fffe.32adda ptp4l[358.116]: foreign master not using PTP timescale ptp4l[358.116]: port 1: MASTER to UNCALIBRATED on RS_SLAVE ptp4l[359.534]: port 1: delay timeout ptp4l[359.534]: delay filtered 14279 raw 14279 ptp4l[360.116]: master offset 30339 s0 freq -3113 path delay 14279 ptp4l[360.587]: port 1: delay timeout ptp4l[360.587]: delay filtered 14617 raw 14955 ptp4l[360.797]: port 1: delay timeout ptp4l[360.797]: delay filtered 14654 raw 14654 ptp4l[361.116]: master offset 27691 s0 freq -3113 path delay 14654 ptp4l[362.116]: master offset 30463 s0 freq -3113 path delay 14654 ptp4l[362.546]: port 1: delay timeout ptp4l[362.546]: delay filtered 14804 raw 16696 ptp4l[363.116]: master offset 25880 s0 freq -3113 path delay 14804 ptp4l[363.213]: port 1: delay timeout ptp4l[363.214]: delay filtered 14955 raw 15879 ptp4l[364.116]: master offset 24561 s0 freq -3113 path delay 14955 ptp4l[365.116]: master offset 27228 s0 freq -3113 path delay 14955 ptp4l[365.128]: port 1: delay timeout ptp4l[365.129]: delay filtered 15359 raw 15763 ptp4l[366.116]: master offset 22665 s0 freq -3113 path delay 15359 ptp4l[366.459]: port 1: delay timeout ptp4l[366.459]: delay filtered 14955 raw 14754 ptp4l[366.574]: port 1: delay timeout ptp4l[366.574]: delay filtered 14854 raw 13635 ptp4l[366.837]: port 1: delay timeout ptp4l[366.837]: delay filtered 14754 raw 13916 ptp4l[367.008]: port 1: delay timeout ptp4l[367.009]: delay filtered 14704 raw 14019 ptp4l[367.116]: master offset 22521 s0 freq -3113 path delay 14704 ptp4l[367.323]: port 1: delay timeout ptp4l[367.323]: delay filtered 14854 raw 15704 ptp4l[368.116]: master offset 21827 s0 freq -3113 path delay 14854 ptp4l[368.221]: port 1: delay timeout ptp4l[368.221]: delay filtered 14704 raw 13648 ptp4l[368.624]: port 1: delay timeout ptp4l[368.624]: delay filtered 15229 raw 16203 ptp4l[369.116]: master offset 21377 s0 freq -3113 path delay 15229 ptp4l[369.194]: port 1: delay timeout ptp4l[369.194]: delay filtered 14386 raw 13856
