INFO 367.019252872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.111353072 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.236522352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.361570376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.487114920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.624236400 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.737823472 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 367.863001120 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 368.001124496 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454323141564 ignored INFO 368.019502896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.113331720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.238270696 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.363792272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.489336200 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.624467000 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.739436152 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 368.865093776 avtp process_stats_print : events 0/ 0/ 0/ 0 sched_intvl 1999583/ 2007299/ 2015542 processing time 583/ 627/ 6334 (ns) INFO 368.865093776 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 369.001104752 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454405919632 ignored INFO 369.019752896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.115318176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.240489672 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.365911320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.491345520 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.624719624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.742039296 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 369.867580720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) Net Port(0): PortStatRxPkts 7266 PortStatTxPkts 1099 PortStatRxErrEtype 0 PortStatRxErrPortId 0 PortStatTxErr 3 PortStatTxErrAlloc 0 PortStatHwTsRequest 736 PortStatHwTsHandler 733 CMLDS Port(0): linkPortEnabled: Disabled Port(0): domain(0, 0): Role: Disabled Link: Up asCapable: No neighborGptpCapable: No delayMechanism: P2P Port(0): Propagation delay (ns): 5209.50 min 3879 avg 5442 max 6368 variance 440819 Port(0): domain(0, 0): PortStatRxPkts 0 PortStatRxSyncCount 2901 PortStatRxSyncReceiptTimeouts 0 PortStatRxFollowUpCount 2901 PortStatRxFollowUpTimeouts 0 PortStatRxAnnounce 364 PortStatAnnounceReceiptTimeouts 0 PortStatAnnounceReceiptDropped 0 PortStatRxSignaling 0 PortStatTxPkts 0 PortStatTxSyncCount 0 PortStatTxFollowUpCount 0 PortStatTxAnnounce 0 PortStatTxSignaling 0 PortStatAdjustOnSync 0 PortStatMdSyncRcvSmReset 2902 PortStatNumSynchronizationLoss 0 PortStatNumNotAsCapable 0 Port(0): Peer ClockIdentity 0xb49691fffe8c899e PortStatRxPdelayRequest 366 PortStatRxPdelayResponse 367 PortStatRxPdelayResponseFollowUp 367 rxPdelayRespLostExceeded 0 PortStatTxPdelayRequest 370 PortStatTxPdelayResponse 366 PortStatTxPdelayResponseFollowUp 366 PortStatMdPdelayReqSmReset 3 Heap used: 65976, free: 133960, min free: 124944 Malloc failed counter: 0 Total CPU load : 9.20 INFO 370.000878400 avb-freertos hw_timer_stats : hw_timer runtime stats min 23 mean 23 max 23 rms^2 529 stddev^2 0 INFO 370.000878400 avb-freertos hw_timer_stats : hw_timer delay stats min 12 mean 12 max 39 rms^2 154 stddev^2 4 INFO 370.000878400 avb-freertos hr_timer_task_stats : hr timer task(2000495C) INFO 370.000878400 avb-freertos hr_timer_task_stats : enqueue: 1, cancel: 0, run: 1 INFO 370.000878400 avb-freertos hr_timer_task_stats : errors sched: 0, timeout: 0 INFO 370.000878400 avb-freertos hr_timer_stats : timer(20021D28), hw_timer(20000164), clock id: 0 INFO 370.000878400 avb-freertos hr_timer_stats : period: 125000, next_event: 371351819668 INFO 370.000878400 avb-freertos hr_timer_stats : start: 1, stop: 0, events: 2947441, clock discont: 0 INFO 370.000878400 avb-freertos hr_timer_stats : errors start: 0, event: 0, event isr: 0, clock: 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : adjust = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : reset = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : start = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : stop = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : GPTP error = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : GPTP start error = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : GPTP gettime error = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : measurement error = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : watchdog error = 0 INFO 370.000878400 avb-freertos mclock_rec_pll_stats : ts error = 0 ERR 370.000878400 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454396826430 ignored INFO 370.000878400 avb-freertos mclock_rec_pll_stats : drift error = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : error (Hz/s) = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : gpt_rec event = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : gpt_rec event fec = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : fec_reloaded = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : numerator = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : measure = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : err_set_pll_rate = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : err_pll_prec = 0 INFO 370.001114296 avb-freertos mclock_rec_pll_stats : last_app_adjust = 0 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : reset = 0 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : start = 0 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : stop = 0 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : TS period = 3333333 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : PTP now = 0 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : drift error = 0 INFO 370.001114296 avb-freertos mclock_gen_ptp_stats : PTP jump error = 0 INFO 370.001114296 avb-freertos net_port_show_stats : port0 rx statistics: INFO 370.001114296 avb-freertos net_port_show_stats : gptp rx: 7268, dropped: 0, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : avtp rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : mrp rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : l2 rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : other rx: 0, dropped: 51, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : maap rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : avdecc rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 370.001114296 avb-freertos net_port_show_stats : port0 queues statistics: INFO 370.001114296 avb-freertos net_port_show_stats : rx: INFO 370.001114296 avb-freertos net_port_show_stats : q3 rx: 0, err: 0, err_alloc: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q2 rx: 0, err: 0, err_alloc: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q1 rx: 7268, err: 0, err_alloc: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q0 rx: 51, err: 0, err_alloc: 0 INFO 370.001114296 avb-freertos net_port_show_stats : tx: INFO 370.001114296 avb-freertos net_port_show_stats : q4 tx: 0, err: 0, err_ts: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q3 tx: 0, err: 0, err_ts: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q2 tx: 1100, err: 0, err_ts: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q1 tx: 0, err: 0, err_ts: 0 INFO 370.001114296 avb-freertos net_port_show_stats : q0 tx: 0, err: 0, err_ts: 0 INFO 370.020502896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.118171272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.243342648 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.368761720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.494186152 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.624962400 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.744781576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 370.869846320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 371.000974576 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454386259376 ignored INFO 371.020627896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.120659296 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.246074872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.371609920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.497153096 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.625183200 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.748103320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 371.873157224 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 372.001049200 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454405442016 ignored INFO 372.020877872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 372.124470520 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 372.249511624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 372.375050176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 372.500469376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 372.625512248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 372.751052472 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 373.001007096 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454319110402 ignored INFO 373.001148320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.021127872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.126906896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.252068352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.377229320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.625690920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.628057248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 373.753225096 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 374.001073472 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454402375694 ignored INFO 374.001214272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.021504952 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.128977800 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.254014448 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.379558872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.625915920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.630150296 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 374.755317096 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 375.000876272 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454323434564 ignored INFO 375.001188424 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.021627896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.131066976 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.256501024 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.381645352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.626631776 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.632360152 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 375.757398472 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 376.001131872 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454272563674 ignored INFO 376.001272624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.021877872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.133512752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.259051696 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.384477576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.626808896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.634903272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 376.760430752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 377.001146224 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454139309518 ignored INFO 377.001286720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.022127896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.136265720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.261679552 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.386716496 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.627064248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.637664720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 377.762807776 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 378.000876248 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454154655500 ignored INFO 378.001069200 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.022378352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.138304000 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.263450672 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.388732424 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.627720576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.639302048 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 378.764726320 avtp process_stats_print : events 0/ 0/ 0/ 0 sched_intvl 2001916/ 2007350/ 2012709 processing time 583/ 625/ 5917 (ns) INFO 378.764726320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 379.000876248 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454025365486 ignored INFO 379.001105376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.022632976 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.140566376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.265624176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.390891520 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.628396976 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.641473176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 379.766521976 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) Net Port(0): PortStatRxPkts 7464 PortStatTxPkts 1129 PortStatRxErrEtype 0 PortStatRxErrPortId 0 PortStatTxErr 3 PortStatTxErrAlloc 0 PortStatHwTsRequest 756 PortStatHwTsHandler 753 CMLDS Port(0): linkPortEnabled: Disabled Port(0): domain(0, 0): Role: Disabled Link: Up asCapable: No neighborGptpCapable: No delayMechanism: P2P Port(0): Propagation delay (ns): 3866.00 min 2960 avg 5034 max 7716 variance 2531338 Port(0): domain(0, 0): PortStatRxPkts 0 PortStatRxSyncCount 2980 PortStatRxSyncReceiptTimeouts 0 PortStatRxFollowUpCount 2980 PortStatRxFollowUpTimeouts 0 PortStatRxAnnounce 374 PortStatAnnounceReceiptTimeouts 0 PortStatAnnounceReceiptDropped 0 PortStatRxSignaling 0 PortStatTxPkts 0 PortStatTxSyncCount 0 PortStatTxFollowUpCount 0 PortStatTxAnnounce 0 PortStatTxSignaling 0 PortStatAdjustOnSync 0 PortStatMdSyncRcvSmReset 2981 PortStatNumSynchronizationLoss 0 PortStatNumNotAsCapable 0 Port(0): Peer ClockIdentity 0xb49691fffe8c899e PortStatRxPdelayRequest 376 PortStatRxPdelayResponse 377 PortStatRxPdelayResponseFollowUp 377 rxPdelayRespLostExceeded 0 PortStatTxPdelayRequest 380 PortStatTxPdelayResponse 376 PortStatTxPdelayResponseFollowUp 376 PortStatMdPdelayReqSmReset 3 Heap used: 66240, free: 133696, min free: 124944 Malloc failed counter: 0 Total CPU load : 9.20 INFO 380.000876248 avb-freertos hw_timer_stats : hw_timer runtime stats min 23 mean 23 max 23 rms^2 529 stddev^2 0 INFO 380.000876248 avb-freertos hw_timer_stats : hw_timer delay stats min 12 mean 12 max 39 rms^2 154 stddev^2 4 INFO 380.000876248 avb-freertos hr_timer_task_stats : hr timer task(2000495C) INFO 380.000876248 avb-freertos hr_timer_task_stats : enqueue: 1, cancel: 0, run: 1 INFO 380.000876248 avb-freertos hr_timer_task_stats : errors sched: 0, timeout: 0 INFO 380.000876248 avb-freertos hr_timer_stats : timer(20021D28), hw_timer(20000164), clock id: 0 INFO 380.000876248 avb-freertos hr_timer_stats : period: 125000, next_event: 381388694668 INFO 380.000876248 avb-freertos hr_timer_stats : start: 1, stop: 0, events: 3027735, clock discont: 0 INFO 380.000876248 avb-freertos hr_timer_stats : errors start: 0, event: 0, event isr: 0, clock: 0 INFO 380.000876248 avb-freertos mclock_rec_pll_stats : adjust = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : reset = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : start = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : stop = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : GPTP error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : GPTP start error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : GPTP gettime error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : measurement error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : watchdog error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : ts error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : drift error = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : error (Hz/s) = 0 INFO 380.001015320 avb-freertos mclock_rec_pll_stats : gpt_rec event = 0 ERR 380.001015320 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454112275544 ignored INFO 380.001015320 avb-freertos mclock_rec_pll_stats : gpt_rec event fec = 0 INFO 380.001154576 avb-freertos mclock_rec_pll_stats : fec_reloaded = 0 INFO 380.001154576 avb-freertos mclock_rec_pll_stats : numerator = 0 INFO 380.001154576 avb-freertos mclock_rec_pll_stats : measure = 0 INFO 380.001154576 avb-freertos mclock_rec_pll_stats : err_set_pll_rate = 0 INFO 380.001154576 avb-freertos mclock_rec_pll_stats : err_pll_prec = 0 INFO 380.001154576 avb-freertos mclock_rec_pll_stats : last_app_adjust = 0 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : reset = 0 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : start = 0 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : stop = 0 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : TS period = 3333333 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : PTP now = 0 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : drift error = 0 INFO 380.001154576 avb-freertos mclock_gen_ptp_stats : PTP jump error = 0 INFO 380.001154576 avb-freertos net_port_show_stats : port0 rx statistics: INFO 380.001154576 avb-freertos net_port_show_stats : gptp rx: 7466, dropped: 0, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : avtp rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : mrp rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : l2 rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : other rx: 0, dropped: 51, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : maap rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : avdecc rx: 0, dropped: 0, slow: 0, slow_dropped: 0 INFO 380.001154576 avb-freertos net_port_show_stats : port0 queues statistics: INFO 380.001154576 avb-freertos net_port_show_stats : rx: INFO 380.001154576 avb-freertos net_port_show_stats : q3 rx: 0, err: 0, err_alloc: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q2 rx: 0, err: 0, err_alloc: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q1 rx: 7466, err: 0, err_alloc: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q0 rx: 51, err: 0, err_alloc: 0 INFO 380.001154576 avb-freertos net_port_show_stats : tx: INFO 380.001154576 avb-freertos net_port_show_stats : q4 tx: 0, err: 0, err_ts: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q3 tx: 0, err: 0, err_ts: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q2 tx: 1130, err: 0, err_ts: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q1 tx: 0, err: 0, err_ts: 0 INFO 380.001154576 avb-freertos net_port_show_stats : q0 tx: 0, err: 0, err_ts: 0 INFO 380.001154576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.023127896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.142268824 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.267418576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.392716720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.628999000 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.643191624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 380.768258496 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 381.001132152 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454037421804 ignored INFO 381.001273576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.023377896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.144474152 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.269522920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.394795976 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.629561648 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.645756576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 381.770811248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 382.001084176 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454127486912 ignored INFO 382.001224648 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.023757400 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.147420648 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.272582376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.398125776 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.629891320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.648697072 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 382.774224800 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 383.001134072 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454067761398 ignored INFO 383.024377896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.024686552 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.149718424 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.275257848 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.400785752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.630167672 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.651090648 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 383.776256576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 384.001159376 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454060010484 ignored INFO 384.025002896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.026704824 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.151865496 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.277013496 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.402171672 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.630576248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.652750176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 384.777907272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 385.001077600 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373453965651080 ignored INFO 385.025502872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.028600224 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.154139024 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.279180448 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.404595920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.630769224 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.655194448 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 385.780347472 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 386.001163600 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454031718576 ignored INFO 386.026252896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.030556520 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.155722824 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.281263576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.406802920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.631108400 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.657760376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 386.783299696 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 387.001129576 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454029075838 ignored INFO 387.026877896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.033756600 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.158917848 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.284083352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.409506624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.631308248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.660201448 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 387.785735624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 388.001191224 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373454057224476 ignored INFO 388.027002896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 388.036076872 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 388.161234776 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 388.286881576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 388.412290352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) Starting GPT timer(400f8000), frequency: 11718 Copyright 2020 NXP AVB>>directory /avb_app doesn't exist lfs_file_open(/fgptp/priority1) failed: -2 lfs_file_open(/fgptp/priority2) failed: -2 lfs_file_open(/fgptp/clockClass) failed: -2 lfs_file_open(/fgptp/clockAccuracy) failed: -2 lfs_file_open(/fgptp/offsetScaledLogVariance) failed: -2 lfs_file_open(/fgptp/domain1/domain_number) failed: -2 lfs_file_open(/fgptp/domain1/gmCapable) failed: -2 lfs_file_open(/fgptp/domain1/priority1) failed: -2 lfs_file_open(/fgptp/domain1/priority2) failed: -2 lfs_file_open(/fgptp/domain1/clockClass) failed: -2 lfs_file_open(/fgptp/domain1/clockAccuracy) failed: -2 lfs_file_open(/fgptp/domain1/offsetScaledLogVariance) failed: -2 lfs_file_open(/fgptp/port0/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port0/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port1/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port1/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port2/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port2/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port3/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port3/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port4/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port4/txDelayCompensation) failed: -2 directory /avdecc doesn't exist INIT 0.000000000 avb-freertos genavb_init : directory /port0 doesn't exist NXP's GenAVB/TSN stack version 4_3_0 (Built Jan 4 2024 13:49:02) INIT 0.000000000 avb-freertos mclock_register_device : dev(2001B114) INIT 0.000000000 avb-freertos mclock_gen_ptp_init : registered gen_ptp device 2001B114 INIT 0.000000000 avb-freertos hw_avb_timer_init : hw_timer_init done INIT 0.000000000 avb-freertos hw_clock_init : rate: 24000000, period: 100000000, mult(to ns): 699050667, shift(to ns): 24, mult(to cycles): 103079215, shift(to cycles): 32 INIT 0.000000000 avb-freertos hw_clock_register : hw clock id: 1 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(2000011C) of clock id: 1 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(20000140) of clock id: 1 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(20000164) of clock id: 1 registered INFO 0.000000000 avb-freertos hw_avb_timer_register_device : dev(20000390) , ref clock 12288000 Hz, min delay cycles 122 INFO 0.000000000 avb-freertos gpt_hw_timer_set_period : gpt_dev (20000370) set period 125(us), 1536(cycles) INIT 0.000000000 avb-freertos gpt_init : gpt_init : registered AVB HW timer(20000390) channel: 0, prescale: 1 INIT 0.000000000 avb-freertos mclock_register_device : dev(20000428) INIT 0.000000000 avb-freertos gpt_rec_init : rec device(20000428), clk input: 12288000 Hz, pll frequency 786432000, pll parent (osc) frequency 24000000 INIT 0.000000000 avb-freertos __port_init : port(0): 2000217C INIT 0.000000000 avb-freertos enet_qos_init : port(0) enet(0) ptp clock: 200000000 Hz, core clock: 240000000 Hz num TX queue: 5, num RX queue: 4 INIT 0.000000000 avb-freertos hw_clock_init : rate: 1000000000, period: 3b9ac9ffc4653600, mult(to ns): 1, shift(to ns): 0, mult(to cycles): 1, shift(to cycles): 0 INIT 0.000000000 avb-freertos hw_clock_register : hw clock id: 2 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(200028CC) of clock id: 2 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(200028F0) of clock id: 2 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(20002914) of clock id: 2 registered, pps support INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 0 success, flags: 0 ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 1 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 2 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 3 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 4 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 5 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 6 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 7 has no hw clock INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 8 success, flags: 1 INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 9 success, flags: 0 ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 10 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 11 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 12 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 13 has no hw clock INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 14 success, flags: 4 ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 15 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 16 has no hw clock INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : port(0) num tc: 5, num sr: 2, num hw queues: 5 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : num hw queues: 5, num cbs: 2 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(0)->hw_queue_id: 0, flags: 2, hw queue prop: 1 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(1)->hw_queue_id: 1, flags: 2, hw queue prop: 1 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(2)->hw_queue_id: 2, flags: 2, hw queue prop: 1 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(3)->hw_queue_id: 3, flags: 1, hw queue prop: 2 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(4)->hw_queue_id: 4, flags: 1, hw queue prop: 2 INFO 0.000000000 avb-freertos hw_timer_request : hw_timer(20000164) INFO 0.000000000 avb-freertos os_timer_create : os_timer(20019924), queue: 0 INIT 0.000000000 avb-freertos net_tx_task : networking(20019A28) tx task started INIT 0.000000000 avb-freertos net_rx_task : networking(20019848) rx task started INIT 0.000000000 avb-freertos net_task_init : networking started INFO 0.000000000 avb-freertos timer_system_create : os_timer(20002988), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(20002988), queue: 0 INIT 0.000000000 avb-freertos hw_avb_timer_start : hw_timer_start done INIT 0.000000000 avb-freertos gptp_task : gptp task started INFO 0.000000000 gptp gptp_check_config : gptp config is valid INIT 0.000000000 gptp gptp_init : gptp(20023738) (profile 0 - rsync 0 - num ports = 1 - force_2011 = 1) INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001720, 2002B3A8) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(200017BC, 2002B478) success INFO 0.000000000 gptp gptp_init : Port(0): Delay compensation (rx: 0, tx: 0) INFO 0.000000000 avb-freertos __net_rx_init : socket(2002B548) INFO 0.000000000 avb-freertos __net_tx_init : socket(2002B680) port_id(0) INFO 0.000000000 avb-freertos net_add_multi : port(0) 01:80:c2:00:00:0e INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AE44), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AE44), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AE7C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AE7C), queue: 20023658 INIT 0.000000000 gptp gptp_cmlds_init : CMLDS link port (0) initialized INFO 0.000000000 gptp dump_priority_vector : domain(0, 0) system priority vector: root identity 00bbccfffeddee10 INFO 0.000000000 gptp dump_priority_vector : system priority vector: priority1 255 priority2 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: class 255 accuracy 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: variance 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: source port identity 00bbccfffeddee10, port number 0 INFO 0.000000000 gptp dump_priority_vector : system priority vector: port number 0 steps removed 0 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AEB4), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AEB4), queue: 20023658 INIT 0.000000000 gptp gptp_instance_init : Configuring Port(0) (200297D4) domain(0, 0) delayMechanism(P2P) INIT 0.000000000 gptp gptp_port_init_timers : Port(0) INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AEEC), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AEEC), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AF24), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AF24), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AF5C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AF5C), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AF94), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AF94), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AFCC), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AFCC), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B004), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B004), queue: 20023658 ERR 0.000000000 common timer_start : timer(20029BCC) 0ms period INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B03C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B03C), queue: 20023658 INIT 0.000000000 gptp gptp_instance_init : instance(2002931C) domain(0, 0) is enabled (gm capable 0) INFO 0.000000000 gptp dump_priority_vector : domain(1, -1) system priority vector: root identity 00bbccfffeddee10 INFO 0.000000000 gptp dump_priority_vector : system priority vector: priority1 1 priority2 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: class 1 accuracy 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: variance 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: source port identity 00bbccfffeddee10, port number 0 INFO 0.000000000 gptp dump_priority_vector : system priority vector: port number 0 steps removed 0 INIT 0.000000000 gptp gptp_instance_init : Configuring Port(0) (2002A554) domain(1, -1) delayMechanism(COMMON_P2P) INIT 0.000000000 gptp gptp_port_init_timers : Port(0) INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B074), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B074), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B0AC), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B0AC), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B0E4), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B0E4), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B11C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B11C), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B154), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B154), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B18C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B18C), queue: 20023658 ERR 0.000000000 common timer_start : timer(2002A94C) 0ms period INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B1C4), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B1C4), queue: 20023658 INIT 0.000000000 gptp gptp_instance_init : instance(2002A09C) domain(1, -1) is disabled (gm capable 1) INFO 0.000000000 gptp gptp_link_up : Port(0): link is UP INFO 0.000000000 gptp md_link_delay_interval_setting_s : Port(0): initialLogPdelayReqInterval 0 (1000 ms) ERR 0.000000000 gptp gptp_net_tx : Port(0): cannot transmit packet INFO 0.000000000 gptp md_pdelay_req_sm_initial_send : Port(0): s 1 pdelay_req_interval (ms) 1000 INFO 0.000000000 gptp port_sync_interval_setting_sm_in : Port(0): initialLogSyncInterval -3 (125 ms) INFO 0.000000000 gptp port_announce_interval_setting_s : Port(0) domain(0, 0): initial_log_announce_interval 0 (1000 ms) INIT 0.000000000 avb-freertos ipc_rx_init : ipc(20001684, 2002B898) success INIT 0.000000000 avb-freertos gptp_task_init : gptp main completed INIT 0.000000000 avb-freertos avtp_task : avtp task init INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001C00, 2002DF18) success INIT 0.000000000 avb-freertos ipc_rx_init : ipc(20001A2C, 2002DFE8) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001AC8, 2002E0B8) success INIT 0.000000000 avb-freertos ipc_rx_init : ipc(200012DC, 2002E188) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001378, 2002E258) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001414, 2002E328) success INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CAEC), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CB08), queue: 2002C470 INFO 0.000000000 avb-freertos os_media_clock_gen_init : hw_source(2002CB80) init done INFO 0.000000000 avtp clock_grid_init : grid(2002CB30) nominal_freq 300/1 nominal_period 3333333 jitter 333 INIT 0.000000000 avtp clock_source_init : clock_source(2002CAD0) type: GRID_PRODUCER_PTP, id: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CF5C), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CF78), queue: 2002C470 INIT 0.000000000 avtp clock_source_init : clock_source(2002CF40) type: GRID_PRODUCER_STREAM, id: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CD4C), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CD68), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002CD68) INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002CD4C) INIT 0.000000000 avb-freertos os_media_clock_rec_init : clock id 0, init done INIT 0.000000000 avtp media_clock_rec_init : clock id 0, init done INFO 0.000000000 avtp clock_domain_init : domain(2002CCE8): 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D3C4), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D3E0), queue: 2002C470 INIT 0.000000000 avtp clock_source_init : clock_source(2002D3A8) type: GRID_PRODUCER_STREAM, id: 1 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D1B4), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D1D0), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002D1D0) INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002D1B4) INFO 0.000000000 avtp clock_domain_init : domain(2002D150): 1 INFO 0.000000000 avtp clock_domain_init : domain(2002D5B8): 2 INFO 0.000000000 avtp clock_domain_init : domain(2002DA20): 3 INIT 0.000000000 avtp avtp_init : avtp(2002CA90) done INIT 0.000000000 avb-freertos avtp_task : started INIT 0.000000000 avb-freertos avtp_task_init : avtp main completed INIT 0.000000000 avb-freertos phy_task : phy(1) task started INIT 0.000000000 avb-freertos ipc_rx_init : ipc(20001C00, 2001FBC8) success INIT 0.000000000 avb-freertos stats_task : started INIT 0.000000000 avb-freertos phy_task : phy(1) initialized ERR 1.000792696 gptp gptp_net_tx : Port(0): cannot transmit packet INIT 1.000810976 avb-freertos ipc_rx_init : ipc(20000C28, 2002F3D8) success INIT 1.000810976 avb-freertos ipc_tx_init : ipc(20000B8C, 2002F4A8) success INIT 1.000810976 avb-freertos ipc_rx_init : ipc(20000CC4, 2002F578) success INIT 1.000810976 avb-freertos ipc_rx_init : ipc(20001378, 2002F748) success INIT 1.000810976 avb-freertos ipc_tx_init : ipc(200012DC, 2002F818) success INIT 1.000810976 avb-freertos ipc_rx_init : ipc(20001414, 2002F8E8) success INFO 0 app crf_stream_create : stream_id: 00-00-aa-bb-cc-dd-ee-ff INFO 0 app crf_stream_create : dst_mac: 91-e0-f0-00-fe-ff INIT 1.000810976 avb-freertos ipc_tx_init : ipc(20001A2C, 2002FF00) success INIT 1.000810976 avb-freertos ipc_rx_init : ipc(20001AC8, 2002FFD0) success INFO 1.000810976 avtp clock_domain_ipc_rx_media_stack : INFO 1.000810976 avtp clock_domain_get : ipc id 10 => domain(2002CCE8): 0 INFO 1.000810976 avtp avtp_ipc_rx_media_stack : INFO 1.000810976 avb-freertos timer_system_create : os_timer(2002DEB8), queue: 0 INFO 1.000810976 avb-freertos os_timer_create : os_timer(2002DEB8), queue: 2002C470 INFO 1.000810976 avb-freertos __net_rx_init : socket(200300A0) INFO 1.000810976 avtp clock_domain_get : ipc id 10 => domain(2002CCE8): 0 INFO 1.000810976 avb-freertos net_add_multi : port(0) 91:e0:f0:00:fe:ff INFO 1.000810976 avtp stream_listener_create : listener_stream_id(0000aabbccddeeff) class(1) format(0411400600017700) domain(41140062002CCE8): 0 ERR 0 app _app_msrp_listener_register: 00-00-aa-bb-cc-dd-ee-ff failed: Control message write error ERR 0 app crf_stream_create : app_msrp_talker_register error, rc = -1INFO 1.000810976 avtp avtp_ipc_rx_media_stack : INFO 1.000810976 avtp stream_listener_destroy : listener_stream_id(0000aabbccddeeff) INFO 1.000810976 avb-freertos os_timer_destroy : os_timer(2002DEB8) INFO 1.000810976 avb-freertos timer_system_destroy : os_timer(2002DEB8) INFO 1.000810976 avb-freertos net_del_multi : port(0) 91:e0:f0:00:fe:ff INFO 1.000810976 avb-freertos net_rx_exit : done ERR 0 app control_task2 : media_clock_init failed INIT 1.000810976 avb-freertos ipc_rx_exit : ipc(20001414, 2002F8E8) exit INIT 1.000810976 avb-freertos ipc_rx_exit : ipc(20001378, 2002F748) exit INIT 1.000810976 avb-freertos ipc_tx_exit : ipc(200012DC, 2002F818) exit INIT 1.000810976 avb-freertos ipc_rx_exit : ipc(20000CC4, 2002F578) exit INIT 1.000810976 avb-freertos ipc_rx_exit : ipc(20000C28, 2002F3D8) exit INIT 1.000810976 avb-freertos ipc_tx_exit : ipc(20000B8C, 2002F4A8) exit INFO 1.000810976 avtp stream_listener_stats_print : stream_id(0000aabbccddeeff) INFO 1.000810976 avtp stream_listener_stats_print : rx: 0, clock: 0, tx: 0, subtype err: 0, tx err: 0 INFO 1.000810976 avtp stream_listener_stats_print : lost: 0, mr: 0, tu: 0, subformat err: 0, dropped: 0 INFO 1.000810976 avtp stream_listener_stats_print : now-rx_ts 2147483/ 0/-2147483 avtp_ts-now 2147483/ 0/-2147483 (us) batch 2147483647/ 0/-2147483647/ 0 INFO 1.000810976 avtp avtp_stream_free : stream(2002FB48) ERR 2.000790752 gptp gptp_net_tx : Port(0): cannot transmit packet INFO 2.000809224 avb-freertos port_up : port(0) up, speed:2, duplex:1 ERR 4.001092824 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373451893572674 ignored ERR 5.000876352 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373451962196594 ignored ERR 6.001023424 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373452146477952 ignored INFO 6.001163752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.042007048 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.167064272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.292502272 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.417561352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.543220624 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.668644120 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 6.918006824 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 7.001080352 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373452152941816 ignored INFO 7.001220848 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.044921848 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.170472472 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.295894152 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.421070720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.546500920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.671666072 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 7.918646152 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 8.001095648 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373452290928012 ignored INFO 8.001236176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.048188072 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.173468752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.299264720 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.424938000 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.549989400 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.674788848 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 8.919270648 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) ERR 9.001094872 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373452313664924 ignored INFO 9.001235320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.050909896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.176073248 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.301509120 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.427029176 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.552575400 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.678123776 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.919977048 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) INFO 9.929068824 avtp process_stats_print : events 0/ 0/ 0/ 0 sched_intvl 2001833/ 2009244/ 12067625 processing time 583/ 620/ 5917 (ns) Net Port(0): PortStatRxPkts 90 PortStatTxPkts 21 PortStatRxErrEtype 0 PortStatRxErrPortId 0 PortStatTxErr 3 PortStatTxErrAlloc 0 PortStatHwTsRequest 17 PortStatHwTsHandler 14 CMLDS Port(0): linkPortEnabled: Disabled Port(0): domain(0, 0): Role: Disabled Link: Up asCapable: No neighborGptpCapable: No delayMechanism: P2P Port(0): Propagation delay (ns): 7202.50 min 5997 avg 6708 max 7372 variance 297832 Port(0): domain(0, 0): PortStatRxPkts 0 PortStatRxSyncCount 32 PortStatRxSyncReceiptTimeouts 0 PortStatRxFollowUpCount 32 PortStatRxFollowUpTimeouts 0 PortStatRxAnnounce 5 PortStatAnnounceReceiptTimeouts 0 PortStatAnnounceReceiptDropped 0 PortStatRxSignaling 0 PortStatTxPkts 0 PortStatTxSyncCount 0 PortStatTxFollowUpCount 0 PortStatTxAnnounce 0 PortStatTxSignaling 0 PortStatAdjustOnSync 0 PortStatMdSyncRcvSmReset 33 PortStatNumSynchronizationLoss 0 PortStatNumNotAsCapable 0 Port(0): Peer ClockIdentity 0xb49691fffe8c899e PortStatRxPdelayRequest 7 PortStatRxPdelayResponse 7 PortStatRxPdelayResponseFollowUp 7 rxPdelayRespLostExceeded 0 PortStatTxPdelayRequest 10 PortStatTxPdelayResponse 7 PortStatTxPdelayResponseFollowUp 7 PortStatMdPdelayReqSmReset 3 Heap used: 66240, free: 133696, min free: 124944 Malloc failed counter: 0 Total CPU load : 7.78 INFO 10.000805000 avb-freertos hw_timer_stats : hw_timer runtime stats min 22 mean 22 max 23 rms^2 528 stddev^2 0 INFO 10.000805000 avb-freertos hw_timer_stats : hw_timer delay stats min 12 mean 12 max 39 rms^2 151 stddev^2 3 INFO 10.000805000 avb-freertos hr_timer_task_stats : hr timer task(2000495C) INFO 10.000805000 avb-freertos hr_timer_task_stats : enqueue: 1, cancel: 0, run: 1 INFO 10.000805000 avb-freertos hr_timer_task_stats : errors sched: 0, timeout: 0 INFO 10.000876296 avb-freertos hr_timer_stats : timer(20021D28), hw_timer(20000164), clock id: 0 INFO 10.000876296 avb-freertos hr_timer_stats : period: 125000, next_event: 10046335793 INFO 10.000876296 avb-freertos hr_timer_stats : start: 1, stop: 0, events: 56997, clock discont: 0 INFO 10.000876296 avb-freertos hr_timer_stats : errors start: 0, event: 0, event isr: 0, clock: 0 INFO 10.000876296 avb-freertos mclock_rec_pll_stats : adjust = 0 INFO 10.000876296 avb-freertos mclock_rec_pll_stats : reset = 0 INFO 10.000876296 avb-freertos mclock_rec_pll_stats : start = 0 INFO 10.000876296 avb-freertos mclock_rec_pll_stats : stop = 0 INFO 10.000876296 avb-freertos mclock_rec_pll_stats : GPTP error = 0 INFO 10.000876296 avb-freertos mclock_rec_pll_staStarting GPT timer(400f8000), frequency: 11718 Copyright 2020 NXP AVB>>directory /avb_app doesn't exist lfs_file_open(/fgptp/priority1) failed: -2 lfs_file_open(/fgptp/priority2) failed: -2 lfs_file_open(/fgptp/clockClass) failed: -2 lfs_file_open(/fgptp/clockAccuracy) failed: -2 lfs_file_open(/fgptp/offsetScaledLogVariance) failed: -2 lfs_file_open(/fgptp/domain1/domain_number) failed: -2 lfs_file_open(/fgptp/domain1/gmCapable) failed: -2 lfs_file_open(/fgptp/domain1/priority1) failed: -2 lfs_file_open(/fgptp/domain1/priority2) failed: -2 lfs_file_open(/fgptp/domain1/clockClass) failed: -2 lfs_file_open(/fgptp/domain1/clockAccuracy) failed: -2 lfs_file_open(/fgptp/domain1/offsetScaledLogVariance) failed: -2 lfs_file_open(/fgptp/port0/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port0/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port1/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port1/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port2/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port2/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port3/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port3/txDelayCompensation) failed: -2 lfs_file_open(/fgptp/port4/rxDelayCompensation) failed: -2 lfs_file_open(/fgptp/port4/txDelayCompensation) failed: -2 directory /avdecc doesn't exist INIT 0.000000000 avb-freertos genavb_init : directory /port0 doesn't exist NXP's GenAVB/TSN stack version 4_3_0 (Built Jan 4 2024 13:49:02) INIT 0.000000000 avb-freertos mclock_register_device : dev(2001B114) INIT 0.000000000 avb-freertos mclock_gen_ptp_init : registered gen_ptp device 2001B114 INIT 0.000000000 avb-freertos hw_avb_timer_init : hw_timer_init done INIT 0.000000000 avb-freertos hw_clock_init : rate: 24000000, period: 100000000, mult(to ns): 699050667, shift(to ns): 24, mult(to cycles): 103079215, shift(to cycles): 32 INIT 0.000000000 avb-freertos hw_clock_register : hw clock id: 1 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(2000011C) of clock id: 1 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(20000140) of clock id: 1 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(20000164) of clock id: 1 registered INFO 0.000000000 avb-freertos hw_avb_timer_register_device : dev(20000390) , ref clock 12288000 Hz, min delay cycles 122 INFO 0.000000000 avb-freertos gpt_hw_timer_set_period : gpt_dev (20000370) set period 125(us), 1536(cycles) INIT 0.000000000 avb-freertos gpt_init : gpt_init : registered AVB HW timer(20000390) channel: 0, prescale: 1 INIT 0.000000000 avb-freertos mclock_register_device : dev(20000428) INIT 0.000000000 avb-freertos gpt_rec_init : rec device(20000428), clk input: 12288000 Hz, pll frequency 786432000, pll parent (osc) frequency 24000000 INIT 0.000000000 avb-freertos __port_init : port(0): 2000217C INIT 0.000000000 avb-freertos enet_qos_init : port(0) enet(0) ptp clock: 200000000 Hz, core clock: 240000000 Hz num TX queue: 5, num RX queue: 4 INIT 0.000000000 avb-freertos hw_clock_init : rate: 1000000000, period: 3b9ac9ffc4653600, mult(to ns): 1, shift(to ns): 0, mult(to cycles): 1, shift(to cycles): 0 INIT 0.000000000 avb-freertos hw_clock_register : hw clock id: 2 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(200028CC) of clock id: 2 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(200028F0) of clock id: 2 registered INIT 0.000000000 avb-freertos hw_timer_register : hw_timer(20002914) of clock id: 2 registered, pps support INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 0 success, flags: 0 ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 1 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 2 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 3 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 4 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 5 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 6 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 7 has no hw clock INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 8 success, flags: 1 INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 9 success, flags: 0 ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 10 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 11 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 12 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 13 has no hw clock INIT 0.000000000 avb-freertos _os_clock_init : clock ID: 14 success, flags: 4 ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 15 has no hw clock ERR 0.000000000 avb-freertos _os_clock_init : clock ID: 16 has no hw clock INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : port(0) num tc: 5, num sr: 2, num hw queues: 5 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : num hw queues: 5, num cbs: 2 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(0)->hw_queue_id: 0, flags: 2, hw queue prop: 1 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(1)->hw_queue_id: 1, flags: 2, hw queue prop: 1 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(2)->hw_queue_id: 2, flags: 2, hw queue prop: 1 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(3)->hw_queue_id: 3, flags: 1, hw queue prop: 2 INFO 0.000000000 avb-freertos net_qos_map_traffic_class_to_hw_ : tc(4)->hw_queue_id: 4, flags: 1, hw queue prop: 2 INFO 0.000000000 avb-freertos hw_timer_request : hw_timer(20000164) INFO 0.000000000 avb-freertos os_timer_create : os_timer(20019924), queue: 0 INIT 0.000000000 avb-freertos net_tx_task : networking(20019A28) tx task started INIT 0.000000000 avb-freertos net_rx_task : networking(20019848) rx task started INIT 0.000000000 avb-freertos net_task_init : networking started INFO 0.000000000 avb-freertos timer_system_create : os_timer(20002988), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(20002988), queue: 0 INIT 0.000000000 avb-freertos hw_avb_timer_start : hw_timer_start done INIT 0.000000000 avb-freertos gptp_task : gptp task started INFO 0.000000000 gptp gptp_check_config : gptp config is valid INIT 0.000000000 gptp gptp_init : gptp(20023738) (profile 0 - rsync 0 - num ports = 1 - force_2011 = 1) INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001720, 2002B3A8) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(200017BC, 2002B478) success INFO 0.000000000 gptp gptp_init : Port(0): Delay compensation (rx: 0, tx: 0) INFO 0.000000000 avb-freertos __net_rx_init : socket(2002B548) INFO 0.000000000 avb-freertos __net_tx_init : socket(2002B680) port_id(0) INFO 0.000000000 avb-freertos net_add_multi : port(0) 01:80:c2:00:00:0e INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AE44), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AE44), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AE7C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AE7C), queue: 20023658 INIT 0.000000000 gptp gptp_cmlds_init : CMLDS link port (0) initialized INFO 0.000000000 gptp dump_priority_vector : domain(0, 0) system priority vector: root identity 00bbccfffeddee10 INFO 0.000000000 gptp dump_priority_vector : system priority vector: priority1 255 priority2 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: class 255 accuracy 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: variance 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: source port identity 00bbccfffeddee10, port number 0 INFO 0.000000000 gptp dump_priority_vector : system priority vector: port number 0 steps removed 0 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AEB4), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AEB4), queue: 20023658 INIT 0.000000000 gptp gptp_instance_init : Configuring Port(0) (200297D4) domain(0, 0) delayMechanism(P2P) INIT 0.000000000 gptp gptp_port_init_timers : Port(0) INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AEEC), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AEEC), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AF24), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AF24), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AF5C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AF5C), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AF94), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AF94), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002AFCC), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002AFCC), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B004), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B004), queue: 20023658 ERR 0.000000000 common timer_start : timer(20029BCC) 0ms period INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B03C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B03C), queue: 20023658 INIT 0.000000000 gptp gptp_instance_init : instance(2002931C) domain(0, 0) is enabled (gm capable 0) INFO 0.000000000 gptp dump_priority_vector : domain(1, -1) system priority vector: root identity 00bbccfffeddee10 INFO 0.000000000 gptp dump_priority_vector : system priority vector: priority1 1 priority2 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: class 1 accuracy 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: variance 1 INFO 0.000000000 gptp dump_priority_vector : system priority vector: source port identity 00bbccfffeddee10, port number 0 INFO 0.000000000 gptp dump_priority_vector : system priority vector: port number 0 steps removed 0 INIT 0.000000000 gptp gptp_instance_init : Configuring Port(0) (2002A554) domain(1, -1) delayMechanism(COMMON_P2P) INIT 0.000000000 gptp gptp_port_init_timers : Port(0) INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B074), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B074), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B0AC), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B0AC), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B0E4), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B0E4), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B11C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B11C), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B154), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B154), queue: 20023658 INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B18C), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B18C), queue: 20023658 ERR 0.000000000 common timer_start : timer(2002A94C) 0ms period INFO 0.000000000 avb-freertos timer_system_create : os_timer(2002B1C4), queue: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002B1C4), queue: 20023658 INIT 0.000000000 gptp gptp_instance_init : instance(2002A09C) domain(1, -1) is disabled (gm capable 1) INFO 0.000000000 gptp gptp_link_up : Port(0): link is UP INFO 0.000000000 gptp md_link_delay_interval_setting_s : Port(0): initialLogPdelayReqInterval 0 (1000 ms) ERR 0.000000000 gptp gptp_net_tx : Port(0): cannot transmit packet INFO 0.000000000 gptp md_pdelay_req_sm_initial_send : Port(0): s 1 pdelay_req_interval (ms) 1000 INFO 0.000000000 gptp port_sync_interval_setting_sm_in : Port(0): initialLogSyncInterval -3 (125 ms) INFO 0.000000000 gptp port_announce_interval_setting_s : Port(0) domain(0, 0): initial_log_announce_interval 0 (1000 ms) INIT 0.000000000 avb-freertos ipc_rx_init : ipc(20001684, 2002B898) success INIT 0.000000000 avb-freertos gptp_task_init : gptp main completed INIT 0.000000000 avb-freertos avtp_task : avtp task init INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001C00, 2002DF18) success INIT 0.000000000 avb-freertos ipc_rx_init : ipc(20001A2C, 2002DFE8) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001AC8, 2002E0B8) success INIT 0.000000000 avb-freertos ipc_rx_init : ipc(200012DC, 2002E188) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001378, 2002E258) success INIT 0.000000000 avb-freertos ipc_tx_init : ipc(20001414, 2002E328) success INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CAEC), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CB08), queue: 2002C470 INFO 0.000000000 avb-freertos os_media_clock_gen_init : hw_source(2002CB80) init done INFO 0.000000000 avtp clock_grid_init : grid(2002CB30) nominal_freq 300/1 nominal_period 3333333 jitter 333 INIT 0.000000000 avtp clock_source_init : clock_source(2002CAD0) type: GRID_PRODUCER_PTP, id: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CF5C), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CF78), queue: 2002C470 INIT 0.000000000 avtp clock_source_init : clock_source(2002CF40) type: GRID_PRODUCER_STREAM, id: 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CD4C), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002CD68), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002CD68) INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002CD4C) INIT 0.000000000 avb-freertos os_media_clock_rec_init : clock id 0, init done INIT 0.000000000 avtp media_clock_rec_init : clock id 0, init done INFO 0.000000000 avtp clock_domain_init : domain(2002CCE8): 0 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D3C4), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D3E0), queue: 2002C470 INIT 0.000000000 avtp clock_source_init : clock_source(2002D3A8) type: GRID_PRODUCER_STREAM, id: 1 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D1B4), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_create : os_timer(2002D1D0), queue: 2002C470 INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002D1D0) INFO 0.000000000 avb-freertos os_timer_destroy : os_timer(2002D1B4) INFO 0.000000000 avtp clock_domain_init : domain(2002D150): 1 INFO 0.000000000 avtp clock_domain_init : domain(2002D5B8): 2 INFO 0.000000000 avtp clock_domain_init : domain(2002DA20): 3 INIT 0.000000000 avtp avtp_init : avtp(2002CA90) done INIT 0.000000000 avb-freertos avtp_task : started INIT 0.000000000 avb-freertos avtp_task_init : avtp main completed INIT 0.000000000 avb-freertos phy_task : phy(1) task started INIT 0.000000000 avb-freertos ipc_rx_init : ipc(20001C00, 2001FBC8) success INIT 0.000000000 avb-freertos stats_task : started INIT 0.000000000 avb-freertos phy_task : phy(1) initialized ERR 1.000845176 gptp gptp_net_tx : Port(0): cannot transmit packet INIT 1.000863096 avb-freertos ipc_rx_init : ipc(20000C28, 2002F3D8) success INIT 1.000863096 avb-freertos ipc_tx_init : ipc(20000B8C, 2002F4A8) success INIT 1.000863096 avb-freertos ipc_rx_init : ipc(20000CC4, 2002F578) success INIT 1.000863096 avb-freertos ipc_rx_init : ipc(20001378, 2002F748) success INIT 1.000863096 avb-freertos ipc_tx_init : ipc(200012DC, 2002F818) success INIT 1.000863096 avb-freertos ipc_rx_init : ipc(20001414, 2002F8E8) success INFO 0 app crf_stream_create : stream_id: 00-00-aa-bb-cc-dd-ee-ff INFO 0 app crf_stream_create : dst_mac: 91-e0-f0-00-fe-ff INIT 1.000863096 avb-freertos ipc_tx_init : ipc(20001A2C, 2002FF00) success INIT 1.000863096 avb-freertos ipc_rx_init : ipc(20001AC8, 2002FFD0) success INFO 1.000863096 avtp clock_domain_ipc_rx_media_stack : INFO 1.000863096 avtp clock_domain_get : ipc id 10 => domain(2002CCE8): 0 INFO 1.000863096 avtp avtp_ipc_rx_media_stack : INFO 1.000863096 avb-freertos timer_system_create : os_timer(2002DEB8), queue: 0 INFO 1.000863096 avb-freertos os_timer_create : os_timer(2002DEB8), queue: 2002C470 INFO 1.000863096 avb-freertos __net_rx_init : socket(200300A0) INFO 1.000863096 avtp clock_domain_get : ipc id 10 => domain(2002CCE8): 0 INFO 1.000863096 avb-freertos net_add_multi : port(0) 91:e0:f0:00:fe:ff INFO 1.000863096 avtp stream_listener_create : listener_stream_id(0000aabbccddeeff) class(1) format(0411400600017700) domain(41140062002CCE8): 0 ERR 0 app _app_msrp_listener_register: 00-00-aa-bb-cc-dd-ee-ff failed: Control message write error ERR 0 app crf_stream_create : app_msrp_talker_register error, rc = -1INFO 1.000863096 avtp avtp_ipc_rx_media_stack : INFO 1.000863096 avtp stream_listener_destroy : listener_stream_id(0000aabbccddeeff) INFO 1.000863096 avb-freertos os_timer_destroy : os_timer(2002DEB8) INFO 1.000863096 avb-freertos timer_system_destroy : os_timer(2002DEB8) INFO 1.000863096 avb-freertos net_del_multi : port(0) 91:e0:f0:00:fe:ff INFO 1.000863096 avb-freertos net_rx_exit : done ERR 0 app control_task2 : media_clock_init failed INIT 1.000863096 avb-freertos ipc_rx_exit : ipc(20001414, 2002F8E8) exit INIT 1.000863096 avb-freertos ipc_rx_exit : ipc(20001378, 2002F748) exit INIT 1.000863096 avb-freertos ipc_tx_exit : ipc(200012DC, 2002F818) exit INIT 1.000863096 avb-freertos ipc_rx_exit : ipc(20000CC4, 2002F578) exit INIT 1.000863096 avb-freertos ipc_rx_exit : ipc(20000C28, 2002F3D8) exit INIT 1.000863096 avb-freertos ipc_tx_exit : ipc(20000B8C, 2002F4A8) exit INFO 1.000863096 avtp stream_listener_stats_print : stream_id(0000aabbccddeeff) INFO 1.000863096 avtp stream_listener_stats_print : rx: 0, clock: 0, tx: 0, subtype err: 0, tx err: 0 INFO 1.000863096 avtp stream_listener_stats_print : lost: 0, mr: 0, tu: 0, subformat err: 0, dropped: 0 INFO 1.000863096 avtp stream_listener_stats_print : now-rx_ts 2147483/ 0/-2147483 avtp_ts-now 2147483/ 0/-2147483 (us) batch 2147483647/ 0/-2147483647/ 0 INFO 1.000863096 avtp avtp_stream_free : stream(2002FB48) ERR 2.000843224 gptp gptp_net_tx : Port(0): cannot transmit packet AVB>>log fgptp debug log all, app, avtp, avdecc, srp, maap, common, os, fgptp, api or mgmt crit, err, init, info or dbg AVB>>log fgptp dbg AVB>>DBG 20.676609624 gptp gptp_dump_header : msg_type ANNOUNCE DBG 20.676609624 gptp gptp_dump_header : transport_specific 1 DBG 20.676609624 gptp gptp_dump_header : version_ptp 2 DBG 20.676609624 gptp gptp_dump_header : minor_version_ptp 1 DBG 20.676609624 gptp gptp_dump_header : msg_length 76 DBG 20.676609624 gptp gptp_dump_header : domain_number 0 DBG 20.676609624 gptp gptp_dump_header : flags 0x08 DBG 20.676609624 gptp gptp_dump_header : correction_field 0 DBG 20.676609624 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 20.676609624 gptp gptp_dump_header : port_number 1 DBG 20.676609624 gptp gptp_dump_header : sequence_id 2878 DBG 20.676609624 gptp gptp_dump_header : control 0 DBG 20.676609624 gptp gptp_dump_header : log_msg_interval 0 DBG 20.676609624 gptp gptp_instance_net_rx : Port(0) domain(0, 0): ANNOUNCE desc port 0, len 90, ts 20768104782 DBG 20.676609624 gptp gptp_handle_announce : Port(0): seq_id=2878 DBG 20.676609624 gptp gptp_dump_announcer_params : gm identity b49691fffe8c899e DBG 20.676609624 gptp gptp_dump_announcer_params : priority1 248 priority2 248 DBG 20.676609624 gptp gptp_dump_announcer_params : class 248 accuracy 254 DBG 20.676609624 gptp gptp_dump_announcer_params : steps_removed 0 DBG 20.768306600 gptp gptp_dump_header : msg_type SYNC DBG 20.768306600 gptp gptp_dump_header : transport_specific 1 DBG 20.768306600 gptp gptp_dump_header : version_ptp 2 DBG 20.768306600 gptp gptp_dump_header : minor_version_ptp 1 DBG 20.768306600 gptp gptp_dump_header : msg_length 44 DBG 20.768306600 gptp gptp_dump_header : domain_number 0 DBG 20.768306600 gptp gptp_dump_header : flags 0x200 DBG 20.768306600 gptp gptp_dump_header : correction_field 0 DBG 20.768306600 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 20.768306600 gptp gptp_dump_header : port_number 1 DBG 20.768306600 gptp gptp_dump_header : sequence_id 22910 DBG 20.768306600 gptp gptp_dump_header : control 0 DBG 20.768306600 gptp gptp_dump_header : log_msg_interval -3 DBG 20.768306600 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 20801496886 DBG 20.768306600 gptp gptp_handle_sync : Port(0): seq_id=22910 INFO 20.768306600 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 20.768306600 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 20.801672496 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 20.801672496 gptp gptp_dump_header : transport_specific 1 DBG 20.801672496 gptp gptp_dump_header : version_ptp 2 DBG 20.801672496 gptp gptp_dump_header : minor_version_ptp 1 DBG 20.801672496 gptp gptp_dump_header : msg_length 76 DBG 20.801672496 gptp gptp_dump_header : domain_number 0 DBG 20.801672496 gptp gptp_dump_header : flags 0x00 DBG 20.801672496 gptp gptp_dump_header : correction_field 0 DBG 20.801672496 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 20.801672496 gptp gptp_dump_header : port_number 1 DBG 20.801672496 gptp gptp_dump_header : sequence_id 22910 DBG 20.801672496 gptp gptp_dump_header : control 0 DBG 20.801672496 gptp gptp_dump_header : log_msg_interval -3 DBG 20.801672496 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 20801584902 DBG 20.801672496 gptp gptp_handle_follow_up : Port(0): seq_id=22910 DBG 20.801672496 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 20.801672496 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 20.801840296 gptp gptp_dump_header : msg_type SYNC DBG 20.801840296 gptp gptp_dump_header : transport_specific 1 DBG 20.801840296 gptp gptp_dump_header : version_ptp 2 DBG 20.801840296 gptp gptp_dump_header : minor_version_ptp 1 DBG 20.801840296 gptp gptp_dump_header : msg_length 44 DBG 20.801840296 gptp gptp_dump_header : domain_number 0 DBG 20.801840296 gptp gptp_dump_header : flags 0x200 DBG 20.801840296 gptp gptp_dump_header : correction_field 0 DBG 20.801840296 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 20.801840296 gptp gptp_dump_header : port_number 1 DBG 20.801840296 gptp gptp_dump_header : sequence_id 22911 DBG 20.801840296 gptp gptp_dump_header : control 0 DBG 20.801840296 gptp gptp_dump_header : log_msg_interval -3 DBG 20.801840296 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 20927015646 DBG 20.801840296 gptp gptp_handle_sync : Port(0): seq_id=22911 INFO 20.801840296 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 20.801840296 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 20.927206520 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 20.927206520 gptp gptp_dump_header : transport_specific 1 DBG 20.927206520 gptp gptp_dump_header : version_ptp 2 DBG 20.927206520 gptp gptp_dump_header : minor_version_ptp 1 DBG 20.927206520 gptp gptp_dump_header : msg_length 76 DBG 20.927206520 gptp gptp_dump_header : domain_number 0 DBG 20.927206520 gptp gptp_dump_header : flags 0x00 DBG 20.927206520 gptp gptp_dump_header : correction_field 0 DBG 20.927206520 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 20.927206520 gptp gptp_dump_header : port_number 1 DBG 20.927206520 gptp gptp_dump_header : sequence_id 22911 DBG 20.927206520 gptp gptp_dump_header : control 0 DBG 20.927206520 gptp gptp_dump_header : log_msg_interval -3 DBG 20.927206520 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 20927181902 DBG 20.927206520 gptp gptp_handle_follow_up : Port(0): seq_id=22911 DBG 20.927206520 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 20.927206520 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 20.927455224 gptp gptp_dump_header : msg_type PDELAY_REQ DBG 20.927455224 gptp gptp_dump_header : transport_specific 1 DBG 20.927455224 gptp gptp_dump_header : version_ptp 2 DBG 20.927455224 gptp gptp_dump_header : minor_version_ptp 1 DBG 20.927455224 gptp gptp_dump_header : msg_length 54 DBG 20.927455224 gptp gptp_dump_header : domain_number 0 DBG 20.927455224 gptp gptp_dump_header : flags 0x00 DBG 20.927455224 gptp gptp_dump_header : correction_field 0 DBG 20.927455224 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 20.927455224 gptp gptp_dump_header : port_number 1 DBG 20.927455224 gptp gptp_dump_header : sequence_id 2951 DBG 20.927455224 gptp gptp_dump_header : control 0 DBG 20.927455224 gptp gptp_dump_header : log_msg_interval 0 DBG 20.927455224 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_REQ desc port 0, len 68, ts 20970132574 DBG 20.927455224 gptp gptp_handle_pdelay_req : Port(0): seq_id=2951 ts 20970132574 DBG 20.927455224 gptp md_set_pdelay_resp : Port(0) DBG 20.927455224 gptp gptp_net_tx : Port(0): PDELAY_RESP len 54 sdoid 1 DBG 20.927455224 gptp gptp_dump_header : msg_type PDELAY_RESP DBG 20.927455224 gptp gptp_dump_header : transport_specific 1 DBG 20.927455224 gptp gptp_dump_header : version_ptp 2 DBG 20.927455224 gptp gptp_dump_header : minor_version_ptp 0 DBG 20.927455224 gptp gptp_dump_header : msg_length 54 DBG 20.927455224 gptp gptp_dump_header : domain_number 0 DBG 20.927455224 gptp gptp_dump_header : flags 0x208 DBG 20.927455224 gptp gptp_dump_header : correction_field 0 DBG 20.927455224 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 20.927455224 gptp gptp_dump_header : port_number 1 DBG 20.927455224 gptp gptp_dump_header : sequence_id 2951 DBG 20.927455224 gptp gptp_dump_header : control 5 DBG 20.927455224 gptp gptp_dump_header : log_msg_interval 127 DBG 20.927455224 gptp gptp_net_tx : Port(0): ts_required - desc->priv 0x01000003 DBG 20.927455224 gptp md_pdelay_resp_sm : Port(0): state WAITING_FOR_PDELAY_REQ event REQ_RECEIVED new state SENT_PDELAY_RESP_WAITING_FOR_TIMESTAMP DBG 20.970567552 gptp gptp_instance_hwts_handler : Port(0) domain(0, 0): ts 20970554586, type 3 PDELAY_RESP DBG 20.970567552 gptp md_set_pdelay_resp_fup : Port(0): ts 20970554586 DBG 20.970567552 gptp gptp_net_tx : Port(0): PDELAY_RESP_FUP len 54 sdoid 1 DBG 20.970567552 gptp gptp_dump_header : msg_type PDELAY_RESP_FUP DBG 20.970567552 gptp gptp_dump_header : transport_specific 1 DBG 20.970567552 gptp gptp_dump_header : version_ptp 2 DBG 20.970567552 gptp gptp_dump_header : minor_version_ptp 0 DBG 20.970567552 gptp gptp_dump_header : msg_length 54 DBG 20.970567552 gptp gptp_dump_header : domain_number 0 DBG 20.970567552 gptp gptp_dump_header : flags 0x08 DBG 20.970567552 gptp gptp_dump_header : correction_field 0 DBG 20.970567552 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 20.970567552 gptp gptp_dump_header : port_number 1 DBG 20.970567552 gptp gptp_dump_header : sequence_id 2951 DBG 20.970567552 gptp gptp_dump_header : control 5 DBG 20.970567552 gptp gptp_dump_header : log_msg_interval 127 DBG 20.970567552 gptp md_pdelay_resp_sm : Port(0): state SENT_PDELAY_RESP_WAITING_FOR_TIMESTAMP event TIMESTAMP_RECEIVED new state WAITING_FOR_PDELAY_REQ DBG 20.970799152 gptp site_sync_sync_sm : state INITIALIZING event PSSYNC RECEIVED new state INITIALIZING DBG 20.970799152 gptp clock_master_sync_send_sm : state SYNC INDICATION event INTERVAL new state SYNC INDICATION DBG 21.000857952 gptp clock_master_sync_send_sm : state INITIALIZING event INTERVAL new state INITIALIZING DBG 21.000880424 gptp gptp_pdelay_req_timer_handler : Port(0) DBG 21.000880424 gptp md_pdelay_req_sm : Port(0): pdelay timing: req_to_ts 111 (min 21 max 111) us req_to_resp 317 us req_to_fup 442 us DBG 21.000880424 gptp md_set_pdelay_req : Port(0) DBG 21.000880424 gptp gptp_net_tx : Port(0): PDELAY_REQ len 54 sdoid 1 DBG 21.000880424 gptp gptp_dump_header : msg_type PDELAY_REQ DBG 21.000880424 gptp gptp_dump_header : transport_specific 1 DBG 21.000880424 gptp gptp_dump_header : version_ptp 2 DBG 21.000880424 gptp gptp_dump_header : minor_version_ptp 0 DBG 21.000880424 gptp gptp_dump_header : msg_length 54 DBG 21.000880424 gptp gptp_dump_header : domain_number 0 DBG 21.000880424 gptp gptp_dump_header : flags 0x08 DBG 21.000880424 gptp gptp_dump_header : correction_field 0 DBG 21.000880424 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 21.000880424 gptp gptp_dump_header : port_number 1 DBG 21.000880424 gptp gptp_dump_header : sequence_id 22 DBG 21.000880424 gptp gptp_dump_header : control 5 DBG 21.000880424 gptp gptp_dump_header : log_msg_interval 0 DBG 21.000880424 gptp gptp_net_tx : Port(0): ts_required - desc->priv 0x01000002 DBG 21.000880424 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_INTERVAL_TIMER event REQ_INTERVAL new state SEND_PDELAY_REQ DBG 21.001072496 gptp gptp_instance_hwts_handler : Port(0) domain(0, 0): ts 21001056818, type 2 PDELAY_REQ DBG 21.001072496 gptp md_pdelay_req_sm : Port(0): event TIMESTAMP_RECEIVED received (req_to_ts 85 us) DBG 21.001072496 gptp md_pdelay_req_sm : Port(0): s 1 state SEND_PDELAY_REQ event TIMESTAMP_RECEIVED new state WAITING_FOR_PDELAY_RESP DBG 21.001165096 gptp gptp_dump_header : msg_type PDELAY_RESP DBG 21.001165096 gptp gptp_dump_header : transport_specific 1 DBG 21.001165096 gptp gptp_dump_header : version_ptp 2 DBG 21.001165096 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.001165096 gptp gptp_dump_header : msg_length 54 DBG 21.001165096 gptp gptp_dump_header : domain_number 0 DBG 21.001165096 gptp gptp_dump_header : flags 0x200 DBG 21.001165096 gptp gptp_dump_header : correction_field 0 DBG 21.001165096 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.001165096 gptp gptp_dump_header : port_number 1 DBG 21.001165096 gptp gptp_dump_header : sequence_id 22 DBG 21.001165096 gptp gptp_dump_header : control 0 DBG 21.001165096 gptp gptp_dump_header : log_msg_interval 127 DBG 21.001165096 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_RESP desc port 0, len 68, ts 21001250446 DBG 21.001165096 gptp gptp_handle_pdelay_resp : Port(0): seq_id=22 ts 21001250446 correction 0 DBG 21.001165096 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_RESP event RESP_RECEIVED new state WAITING_FOR_PDELAY_RESP_FOLLOW_UP DBG 21.001429848 gptp gptp_dump_header : msg_type PDELAY_RESP_FUP DBG 21.001429848 gptp gptp_dump_header : transport_specific 1 DBG 21.001429848 gptp gptp_dump_header : version_ptp 2 DBG 21.001429848 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.001429848 gptp gptp_dump_header : msg_length 54 DBG 21.001429848 gptp gptp_dump_header : domain_number 0 DBG 21.001429848 gptp gptp_dump_header : flags 0x00 DBG 21.001429848 gptp gptp_dump_header : correction_field 0 DBG 21.001429848 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.001429848 gptp gptp_dump_header : port_number 1 DBG 21.001429848 gptp gptp_dump_header : sequence_id 22 DBG 21.001429848 gptp gptp_dump_header : control 0 DBG 21.001429848 gptp gptp_dump_header : log_msg_interval 127 DBG 21.001429848 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_RESP_FUP desc port 0, len 68, ts 21001344286 DBG 21.001429848 gptp gptp_handle_pdelay_resp_fup : Port(0): seq_id=22 sec_msb 0 sec_lsb 1494155264 ns 3866761018 correction 0 DBG 21.001429848 gptp md_pdelay_req_compute_pdelay_rat : Port(0) ERR 21.001429848 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373424793138168 ignored DBG 21.001429848 gptp md_pdelay_req_compute_pdelay_rat : Port(0): prev_pdelay_response_event_ingress_timestamp(20001150054) prev_corrected_responder_event_timestamp(3929037180737) DBG 21.001429848 gptp md_pdelay_req_compute_pdelay_rat : Port(0): pdelay_response_event_ingress_timestamp(21001250446) corrected_responder_event_timestamp(3929974617318) DBG 21.001429848 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 1.0000000000000000 (0 ppb) DBG 21.001429848 gptp md_pdelay_req_compute_prop_time : Port(0) DBG 21.001429848 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay request_receipt_timestamp: secs msb(0) secs lsb(3929) nsecs(974435897) DBG 21.001429848 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay response_origin_timestamp: secs msb(0) secs lsb(3929) nsecs(974617318) DBG 21.001429848 gptp md_pdelay_req_compute_prop_time : Port(0): r 1.0000000000000000 t1(21001056818) t2(3929974435897) t3(3929974617318) t4(21001250446) t4-t1(193628) t3-t2(181421) DBG 21.001429848 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay 6103.50 ns (6103.50 ns) DBG 21.001429848 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_RESP_FOLLOW_UP event FUP_RECEIVED new state WAITING_FOR_PDELAY_INTERVAL_TIMER DBG 21.001737552 gptp gptp_dump_header : msg_type SYNC DBG 21.001737552 gptp gptp_dump_header : transport_specific 1 DBG 21.001737552 gptp gptp_dump_header : version_ptp 2 DBG 21.001737552 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.001737552 gptp gptp_dump_header : msg_length 44 DBG 21.001737552 gptp gptp_dump_header : domain_number 0 DBG 21.001737552 gptp gptp_dump_header : flags 0x200 DBG 21.001737552 gptp gptp_dump_header : correction_field 0 DBG 21.001737552 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.001737552 gptp gptp_dump_header : port_number 1 DBG 21.001737552 gptp gptp_dump_header : sequence_id 22912 DBG 21.001737552 gptp gptp_dump_header : control 0 DBG 21.001737552 gptp gptp_dump_header : log_msg_interval -3 DBG 21.001737552 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21052482358 DBG 21.001737552 gptp gptp_handle_sync : Port(0): seq_id=22912 INFO 21.001737552 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.001737552 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.052752976 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.052752976 gptp gptp_dump_header : transport_specific 1 DBG 21.052752976 gptp gptp_dump_header : version_ptp 2 DBG 21.052752976 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.052752976 gptp gptp_dump_header : msg_length 76 DBG 21.052752976 gptp gptp_dump_header : domain_number 0 DBG 21.052752976 gptp gptp_dump_header : flags 0x00 DBG 21.052752976 gptp gptp_dump_header : correction_field 0 DBG 21.052752976 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.052752976 gptp gptp_dump_header : port_number 1 DBG 21.052752976 gptp gptp_dump_header : sequence_id 22912 DBG 21.052752976 gptp gptp_dump_header : control 0 DBG 21.052752976 gptp gptp_dump_header : log_msg_interval -3 DBG 21.052752976 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21052621086 DBG 21.052752976 gptp gptp_handle_follow_up : Port(0): seq_id=22912 DBG 21.052752976 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.052752976 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.052923552 gptp gptp_dump_header : msg_type SYNC DBG 21.052923552 gptp gptp_dump_header : transport_specific 1 DBG 21.052923552 gptp gptp_dump_header : version_ptp 2 DBG 21.052923552 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.052923552 gptp gptp_dump_header : msg_length 44 DBG 21.052923552 gptp gptp_dump_header : domain_number 0 DBG 21.052923552 gptp gptp_dump_header : flags 0x200 DBG 21.052923552 gptp gptp_dump_header : correction_field 0 DBG 21.052923552 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.052923552 gptp gptp_dump_header : port_number 1 DBG 21.052923552 gptp gptp_dump_header : sequence_id 22913 DBG 21.052923552 gptp gptp_dump_header : control 0 DBG 21.052923552 gptp gptp_dump_header : log_msg_interval -3 DBG 21.052923552 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21177606486 DBG 21.052923552 gptp gptp_handle_sync : Port(0): seq_id=22913 INFO 21.052923552 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.052923552 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.177795576 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.177795576 gptp gptp_dump_header : transport_specific 1 DBG 21.177795576 gptp gptp_dump_header : version_ptp 2 DBG 21.177795576 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.177795576 gptp gptp_dump_header : msg_length 76 DBG 21.177795576 gptp gptp_dump_header : domain_number 0 DBG 21.177795576 gptp gptp_dump_header : flags 0x00 DBG 21.177795576 gptp gptp_dump_header : correction_field 0 DBG 21.177795576 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.177795576 gptp gptp_dump_header : port_number 1 DBG 21.177795576 gptp gptp_dump_header : sequence_id 22913 DBG 21.177795576 gptp gptp_dump_header : control 0 DBG 21.177795576 gptp gptp_dump_header : log_msg_interval -3 DBG 21.177795576 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21177678590 DBG 21.177795576 gptp gptp_handle_follow_up : Port(0): seq_id=22913 DBG 21.177795576 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.177795576 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.177963048 gptp gptp_dump_header : msg_type SYNC DBG 21.177963048 gptp gptp_dump_header : transport_specific 1 DBG 21.177963048 gptp gptp_dump_header : version_ptp 2 DBG 21.177963048 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.177963048 gptp gptp_dump_header : msg_length 44 DBG 21.177963048 gptp gptp_dump_header : domain_number 0 DBG 21.177963048 gptp gptp_dump_header : flags 0x200 DBG 21.177963048 gptp gptp_dump_header : correction_field 0 DBG 21.177963048 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.177963048 gptp gptp_dump_header : port_number 1 DBG 21.177963048 gptp gptp_dump_header : sequence_id 22914 DBG 21.177963048 gptp gptp_dump_header : control 0 DBG 21.177963048 gptp gptp_dump_header : log_msg_interval -3 DBG 21.177963048 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21303093022 DBG 21.177963048 gptp gptp_handle_sync : Port(0): seq_id=22914 INFO 21.177963048 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.177963048 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.303329648 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.303329648 gptp gptp_dump_header : transport_specific 1 DBG 21.303329648 gptp gptp_dump_header : version_ptp 2 DBG 21.303329648 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.303329648 gptp gptp_dump_header : msg_length 76 DBG 21.303329648 gptp gptp_dump_header : domain_number 0 DBG 21.303329648 gptp gptp_dump_header : flags 0x00 DBG 21.303329648 gptp gptp_dump_header : correction_field 0 DBG 21.303329648 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.303329648 gptp gptp_dump_header : port_number 1 DBG 21.303329648 gptp gptp_dump_header : sequence_id 22914 DBG 21.303329648 gptp gptp_dump_header : control 0 DBG 21.303329648 gptp gptp_dump_header : log_msg_interval -3 DBG 21.303329648 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21303245334 DBG 21.303329648 gptp gptp_handle_follow_up : Port(0): seq_id=22914 DBG 21.303329648 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.303329648 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.303502920 gptp gptp_dump_header : msg_type SYNC DBG 21.303502920 gptp gptp_dump_header : transport_specific 1 DBG 21.303502920 gptp gptp_dump_header : version_ptp 2 DBG 21.303502920 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.303502920 gptp gptp_dump_header : msg_length 44 DBG 21.303502920 gptp gptp_dump_header : domain_number 0 DBG 21.303502920 gptp gptp_dump_header : flags 0x200 DBG 21.303502920 gptp gptp_dump_header : correction_field 0 DBG 21.303502920 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.303502920 gptp gptp_dump_header : port_number 1 DBG 21.303502920 gptp gptp_dump_header : sequence_id 22915 DBG 21.303502920 gptp gptp_dump_header : control 0 DBG 21.303502920 gptp gptp_dump_header : log_msg_interval -3 DBG 21.303502920 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21428215654 DBG 21.303502920 gptp gptp_handle_sync : Port(0): seq_id=22915 INFO 21.303502920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.303502920 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.303502920 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.303502920 gptp gptp_dump_header : transport_specific 1 DBG 21.303502920 gptp gptp_dump_header : version_ptp 2 DBG 21.303502920 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.303502920 gptp gptp_dump_header : msg_length 76 DBG 21.303502920 gptp gptp_dump_header : domain_number 0 DBG 21.303502920 gptp gptp_dump_header : flags 0x00 DBG 21.303502920 gptp gptp_dump_header : correction_field 0 DBG 21.303502920 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.303502920 gptp gptp_dump_header : port_number 1 DBG 21.303502920 gptp gptp_dump_header : sequence_id 22915 DBG 21.303502920 gptp gptp_dump_header : control 0 DBG 21.303502920 gptp gptp_dump_header : log_msg_interval -3 DBG 21.303502920 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21428301486 DBG 21.303502920 gptp gptp_handle_follow_up : Port(0): seq_id=22915 DBG 21.303502920 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.303502920 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.428667752 gptp gptp_dump_header : msg_type SYNC DBG 21.428667752 gptp gptp_dump_header : transport_specific 1 DBG 21.428667752 gptp gptp_dump_header : version_ptp 2 DBG 21.428667752 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.428667752 gptp gptp_dump_header : msg_length 44 DBG 21.428667752 gptp gptp_dump_header : domain_number 0 DBG 21.428667752 gptp gptp_dump_header : flags 0x200 DBG 21.428667752 gptp gptp_dump_header : correction_field 0 DBG 21.428667752 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.428667752 gptp gptp_dump_header : port_number 1 DBG 21.428667752 gptp gptp_dump_header : sequence_id 22916 DBG 21.428667752 gptp gptp_dump_header : control 0 DBG 21.428667752 gptp gptp_dump_header : log_msg_interval -3 DBG 21.428667752 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21553603318 DBG 21.428667752 gptp gptp_handle_sync : Port(0): seq_id=22916 INFO 21.428667752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.428667752 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.553794672 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.553794672 gptp gptp_dump_header : transport_specific 1 DBG 21.553794672 gptp gptp_dump_header : version_ptp 2 DBG 21.553794672 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.553794672 gptp gptp_dump_header : msg_length 76 DBG 21.553794672 gptp gptp_dump_header : domain_number 0 DBG 21.553794672 gptp gptp_dump_header : flags 0x00 DBG 21.553794672 gptp gptp_dump_header : correction_field 0 DBG 21.553794672 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.553794672 gptp gptp_dump_header : port_number 1 DBG 21.553794672 gptp gptp_dump_header : sequence_id 22916 DBG 21.553794672 gptp gptp_dump_header : control 0 DBG 21.553794672 gptp gptp_dump_header : log_msg_interval -3 DBG 21.553794672 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21553720238 DBG 21.553794672 gptp gptp_handle_follow_up : Port(0): seq_id=22916 DBG 21.553794672 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.553794672 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.553962048 gptp gptp_dump_header : msg_type SYNC DBG 21.553962048 gptp gptp_dump_header : transport_specific 1 DBG 21.553962048 gptp gptp_dump_header : version_ptp 2 DBG 21.553962048 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.553962048 gptp gptp_dump_header : msg_length 44 DBG 21.553962048 gptp gptp_dump_header : domain_number 0 DBG 21.553962048 gptp gptp_dump_header : flags 0x200 DBG 21.553962048 gptp gptp_dump_header : correction_field 0 DBG 21.553962048 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.553962048 gptp gptp_dump_header : port_number 1 DBG 21.553962048 gptp gptp_dump_header : sequence_id 22917 DBG 21.553962048 gptp gptp_dump_header : control 0 DBG 21.553962048 gptp gptp_dump_header : log_msg_interval -3 DBG 21.553962048 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21678943014 DBG 21.553962048 gptp gptp_handle_sync : Port(0): seq_id=22917 INFO 21.553962048 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.553962048 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.553962048 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.553962048 gptp gptp_dump_header : transport_specific 1 DBG 21.553962048 gptp gptp_dump_header : version_ptp 2 DBG 21.553962048 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.553962048 gptp gptp_dump_header : msg_length 76 DBG 21.553962048 gptp gptp_dump_header : domain_number 0 DBG 21.553962048 gptp gptp_dump_header : flags 0x00 DBG 21.553962048 gptp gptp_dump_header : correction_field 0 DBG 21.553962048 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.553962048 gptp gptp_dump_header : port_number 1 DBG 21.553962048 gptp gptp_dump_header : sequence_id 22917 DBG 21.553962048 gptp gptp_dump_header : control 0 DBG 21.553962048 gptp gptp_dump_header : log_msg_interval -3 DBG 21.553962048 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21678992126 DBG 21.553962048 gptp gptp_handle_follow_up : Port(0): seq_id=22917 DBG 21.553962048 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.553962048 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.679380848 gptp gptp_dump_header : msg_type ANNOUNCE DBG 21.679380848 gptp gptp_dump_header : transport_specific 1 DBG 21.679380848 gptp gptp_dump_header : version_ptp 2 DBG 21.679380848 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.679380848 gptp gptp_dump_header : msg_length 76 DBG 21.679380848 gptp gptp_dump_header : domain_number 0 DBG 21.679380848 gptp gptp_dump_header : flags 0x08 DBG 21.679380848 gptp gptp_dump_header : correction_field 0 DBG 21.679380848 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.679380848 gptp gptp_dump_header : port_number 1 DBG 21.679380848 gptp gptp_dump_header : sequence_id 2879 DBG 21.679380848 gptp gptp_dump_header : control 0 DBG 21.679380848 gptp gptp_dump_header : log_msg_interval 0 DBG 21.679380848 gptp gptp_instance_net_rx : Port(0) domain(0, 0): ANNOUNCE desc port 0, len 90, ts 21768690406 DBG 21.679380848 gptp gptp_handle_announce : Port(0): seq_id=2879 DBG 21.679380848 gptp gptp_dump_announcer_params : gm identity b49691fffe8c899e DBG 21.679380848 gptp gptp_dump_announcer_params : priority1 248 priority2 248 DBG 21.679380848 gptp gptp_dump_announcer_params : class 248 accuracy 254 DBG 21.679380848 gptp gptp_dump_announcer_params : steps_removed 0 DBG 21.768905576 gptp gptp_dump_header : msg_type SYNC DBG 21.768905576 gptp gptp_dump_header : transport_specific 1 DBG 21.768905576 gptp gptp_dump_header : version_ptp 2 DBG 21.768905576 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.768905576 gptp gptp_dump_header : msg_length 44 DBG 21.768905576 gptp gptp_dump_header : domain_number 0 DBG 21.768905576 gptp gptp_dump_header : flags 0x200 DBG 21.768905576 gptp gptp_dump_header : correction_field 0 DBG 21.768905576 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.768905576 gptp gptp_dump_header : port_number 1 DBG 21.768905576 gptp gptp_dump_header : sequence_id 22918 DBG 21.768905576 gptp gptp_dump_header : control 0 DBG 21.768905576 gptp gptp_dump_header : log_msg_interval -3 DBG 21.768905576 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21804423494 DBG 21.768905576 gptp gptp_handle_sync : Port(0): seq_id=22918 INFO 21.768905576 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.768905576 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.804635800 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.804635800 gptp gptp_dump_header : transport_specific 1 DBG 21.804635800 gptp gptp_dump_header : version_ptp 2 DBG 21.804635800 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.804635800 gptp gptp_dump_header : msg_length 76 DBG 21.804635800 gptp gptp_dump_header : domain_number 0 DBG 21.804635800 gptp gptp_dump_header : flags 0x00 DBG 21.804635800 gptp gptp_dump_header : correction_field 0 DBG 21.804635800 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.804635800 gptp gptp_dump_header : port_number 1 DBG 21.804635800 gptp gptp_dump_header : sequence_id 22918 DBG 21.804635800 gptp gptp_dump_header : control 0 DBG 21.804635800 gptp gptp_dump_header : log_msg_interval -3 DBG 21.804635800 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21804484670 DBG 21.804635800 gptp gptp_handle_follow_up : Port(0): seq_id=22918 DBG 21.804635800 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.804635800 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.804803120 gptp gptp_dump_header : msg_type SYNC DBG 21.804803120 gptp gptp_dump_header : transport_specific 1 DBG 21.804803120 gptp gptp_dump_header : version_ptp 2 DBG 21.804803120 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.804803120 gptp gptp_dump_header : msg_length 44 DBG 21.804803120 gptp gptp_dump_header : domain_number 0 DBG 21.804803120 gptp gptp_dump_header : flags 0x200 DBG 21.804803120 gptp gptp_dump_header : correction_field 0 DBG 21.804803120 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.804803120 gptp gptp_dump_header : port_number 1 DBG 21.804803120 gptp gptp_dump_header : sequence_id 22919 DBG 21.804803120 gptp gptp_dump_header : control 0 DBG 21.804803120 gptp gptp_dump_header : log_msg_interval -3 DBG 21.804803120 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 21929550286 DBG 21.804803120 gptp gptp_handle_sync : Port(0): seq_id=22919 INFO 21.804803120 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 21.804803120 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 21.804803120 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 21.804803120 gptp gptp_dump_header : transport_specific 1 DBG 21.804803120 gptp gptp_dump_header : version_ptp 2 DBG 21.804803120 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.804803120 gptp gptp_dump_header : msg_length 76 DBG 21.804803120 gptp gptp_dump_header : domain_number 0 DBG 21.804803120 gptp gptp_dump_header : flags 0x00 DBG 21.804803120 gptp gptp_dump_header : correction_field 0 DBG 21.804803120 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.804803120 gptp gptp_dump_header : port_number 1 DBG 21.804803120 gptp gptp_dump_header : sequence_id 22919 DBG 21.804803120 gptp gptp_dump_header : control 0 DBG 21.804803120 gptp gptp_dump_header : log_msg_interval -3 DBG 21.804803120 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 21929617342 DBG 21.804803120 gptp gptp_handle_follow_up : Port(0): seq_id=22919 DBG 21.804803120 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 21.804803120 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 21.929968896 gptp gptp_dump_header : msg_type PDELAY_REQ DBG 21.929968896 gptp gptp_dump_header : transport_specific 1 DBG 21.929968896 gptp gptp_dump_header : version_ptp 2 DBG 21.929968896 gptp gptp_dump_header : minor_version_ptp 1 DBG 21.929968896 gptp gptp_dump_header : msg_length 54 DBG 21.929968896 gptp gptp_dump_header : domain_number 0 DBG 21.929968896 gptp gptp_dump_header : flags 0x00 DBG 21.929968896 gptp gptp_dump_header : correction_field 0 DBG 21.929968896 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 21.929968896 gptp gptp_dump_header : port_number 1 DBG 21.929968896 gptp gptp_dump_header : sequence_id 2952 DBG 21.929968896 gptp gptp_dump_header : control 0 DBG 21.929968896 gptp gptp_dump_header : log_msg_interval 0 DBG 21.929968896 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_REQ desc port 0, len 68, ts 21970385190 DBG 21.929968896 gptp gptp_handle_pdelay_req : Port(0): seq_id=2952 ts 21970385190 DBG 21.929968896 gptp md_set_pdelay_resp : Port(0) DBG 21.929968896 gptp gptp_net_tx : Port(0): PDELAY_RESP len 54 sdoid 1 DBG 21.929968896 gptp gptp_dump_header : msg_type PDELAY_RESP DBG 21.929968896 gptp gptp_dump_header : transport_specific 1 DBG 21.929968896 gptp gptp_dump_header : version_ptp 2 DBG 21.929968896 gptp gptp_dump_header : minor_version_ptp 0 DBG 21.929968896 gptp gptp_dump_header : msg_length 54 DBG 21.929968896 gptp gptp_dump_header : domain_number 0 DBG 21.929968896 gptp gptp_dump_header : flags 0x208 DBG 21.929968896 gptp gptp_dump_header : correction_field 0 DBG 21.929968896 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 21.929968896 gptp gptp_dump_header : port_number 1 DBG 21.929968896 gptp gptp_dump_header : sequence_id 2952 DBG 21.929968896 gptp gptp_dump_header : control 5 DBG 21.929968896 gptp gptp_dump_header : log_msg_interval 127 DBG 21.929968896 gptp gptp_net_tx : Port(0): ts_required - desc->priv 0x01000003 DBG 21.929968896 gptp md_pdelay_resp_sm : Port(0): state WAITING_FOR_PDELAY_REQ event REQ_RECEIVED new state SENT_PDELAY_RESP_WAITING_FOR_TIMESTAMP DBG 21.970802552 gptp gptp_instance_hwts_handler : Port(0) domain(0, 0): ts 21970789738, type 3 PDELAY_RESP DBG 21.970802552 gptp md_set_pdelay_resp_fup : Port(0): ts 21970789738 DBG 21.970802552 gptp gptp_net_tx : Port(0): PDELAY_RESP_FUP len 54 sdoid 1 DBG 21.970802552 gptp gptp_dump_header : msg_type PDELAY_RESP_FUP DBG 21.970802552 gptp gptp_dump_header : transport_specific 1 DBG 21.970802552 gptp gptp_dump_header : version_ptp 2 DBG 21.970802552 gptp gptp_dump_header : minor_version_ptp 0 DBG 21.970802552 gptp gptp_dump_header : msg_length 54 DBG 21.970802552 gptp gptp_dump_header : domain_number 0 DBG 21.970802552 gptp gptp_dump_header : flags 0x08 DBG 21.970802552 gptp gptp_dump_header : correction_field 0 DBG 21.970802552 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 21.970802552 gptp gptp_dump_header : port_number 1 DBG 21.970802552 gptp gptp_dump_header : sequence_id 2952 DBG 21.970802552 gptp gptp_dump_header : control 5 DBG 21.970802552 gptp gptp_dump_header : log_msg_interval 127 DBG 21.970802552 gptp md_pdelay_resp_sm : Port(0): state SENT_PDELAY_RESP_WAITING_FOR_TIMESTAMP event TIMESTAMP_RECEIVED new state WAITING_FOR_PDELAY_REQ DBG 21.971044672 gptp site_sync_sync_sm : state INITIALIZING event PSSYNC RECEIVED new state INITIALIZING DBG 21.971044672 gptp clock_master_sync_send_sm : state SYNC INDICATION event INTERVAL new state SYNC INDICATION DBG 22.000857672 gptp clock_master_sync_send_sm : state INITIALIZING event INTERVAL new state INITIALIZING DBG 22.000885176 gptp gptp_pdelay_req_timer_handler : Port(0) DBG 22.000885176 gptp md_pdelay_req_sm : Port(0): pdelay timing: req_to_ts 85 (min 21 max 111) us req_to_resp 360 us req_to_fup 523 us DBG 22.000885176 gptp md_set_pdelay_req : Port(0) DBG 22.000885176 gptp gptp_net_tx : Port(0): PDELAY_REQ len 54 sdoid 1 DBG 22.000885176 gptp gptp_dump_header : msg_type PDELAY_REQ DBG 22.000885176 gptp gptp_dump_header : transport_specific 1 DBG 22.000885176 gptp gptp_dump_header : version_ptp 2 DBG 22.000885176 gptp gptp_dump_header : minor_version_ptp 0 DBG 22.000885176 gptp gptp_dump_header : msg_length 54 DBG 22.000885176 gptp gptp_dump_header : domain_number 0 DBG 22.000885176 gptp gptp_dump_header : flags 0x08 DBG 22.000885176 gptp gptp_dump_header : correction_field 0 DBG 22.000885176 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 22.000885176 gptp gptp_dump_header : port_number 1 DBG 22.000885176 gptp gptp_dump_header : sequence_id 23 DBG 22.000885176 gptp gptp_dump_header : control 5 DBG 22.000885176 gptp gptp_dump_header : log_msg_interval 0 DBG 22.000885176 gptp gptp_net_tx : Port(0): ts_required - desc->priv 0x01000002 DBG 22.000885176 gptp md_pdelay_req_sm : Port(0): s 1 st ate WAITING_FOR_PDELAY_INTERVAL_TIMER event REQ_INTERVAL new state SEND_PDELAY_REQ DBG 22.001070720 gptp gptp_instance_hwts_handler : Port(0) domain(0, 0): ts 22001055234, type 2 PDELAY_REQ DBG 22.001070720 gptp md_pdelay_req_sm : Port(0): event TIMESTAMP_RECEIVED received (req_to_ts 87 us) DBG 22.001070720 gptp md_pdelay_req_sm : Port(0): s 1 state SEND_PDELAY_REQ event TIMESTAMP_RECEIVED new state WAITING_FOR_PDELAY_RESP DBG 22.001165496 gptp gptp_dump_header : msg_type PDELAY_RESP DBG 22.001165496 gptp gptp_dump_header : transport_specific 1 DBG 22.001165496 gptp gptp_dump_header : version_ptp 2 DBG 22.001165496 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.001165496 gptp gptp_dump_header : msg_length 54 DBG 22.001165496 gptp gptp_dump_header : domain_number 0 DBG 22.001165496 gptp gptp_dump_header : flags 0x200 DBG 22.001165496 gptp gptp_dump_header : correction_field 0 DBG 22.001165496 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.001165496 gptp gptp_dump_header : port_number 1 DBG 22.001165496 gptp gptp_dump_header : sequence_id 23 DBG 22.001165496 gptp gptp_dump_header : control 0 DBG 22.001165496 gptp gptp_dump_header : log_msg_interval 127 DBG 22.001165496 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_RESP desc port 0, len 68, ts 22001275190 DBG 22.001165496 gptp gptp_handle_pdelay_resp : Port(0): seq_id=23 ts 22001275190 correction 0 DBG 22.001165496 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_RESP event RESP_RECEIVED new state WAITING_FOR_PDELAY_RESP_FOLLOW_UP DBG 22.001539872 gptp gptp_dump_header : msg_type PDELAY_RESP_FUP DBG 22.001539872 gptp gptp_dump_header : transport_specific 1 DBG 22.001539872 gptp gptp_dump_header : version_ptp 2 DBG 22.001539872 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.001539872 gptp gptp_dump_header : msg_length 54 DBG 22.001539872 gptp gptp_dump_header : domain_number 0 DBG 22.001539872 gptp gptp_dump_header : flags 0x00 DBG 22.001539872 gptp gptp_dump_header : correction_field 0 DBG 22.001539872 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.001539872 gptp gptp_dump_header : port_number 1 DBG 22.001539872 gptp gptp_dump_header : sequence_id 23 DBG 22.001539872 gptp gptp_dump_header : control 0 DBG 22.001539872 gptp gptp_dump_header : log_msg_interval 127 DBG 22.001539872 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_RESP_FUP desc port 0, len 68, ts 22001388046 DBG 22.001539872 gptp gptp_handle_pdelay_resp_fup : Port(0): seq_id=23 sec_msb 0 sec_lsb 1510932480 ns 3468778294 correction 0 DBG 22.001539872 gptp md_pdelay_req_compute_pdelay_rat : Port(0) ERR 22.001539872 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373425423961306 ignored DBG 22.001539872 gptp md_pdelay_req_compute_pdelay_rat : Port(0): prev_pdelay_response_event_ingress_timestamp(21001250446) prev_corrected_responder_event_timestamp(3929974617318) DBG 22.001539872 gptp md_pdelay_req_compute_pdelay_rat : Port(0): pdelay_response_event_ingress_timestamp(22001275190) corrected_responder_event_timestamp(3930911983054) DBG 22.001539872 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 1.0000000000000000 (0 ppb) DBG 22.001539872 gptp md_pdelay_req_compute_prop_time : Port(0) DBG 22.001539872 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay request_receipt_timestamp: secs msb(0) secs lsb(3930) nsecs(911776943) DBG 22.001539872 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay response_origin_timestamp: secs msb(0) secs lsb(3930) nsecs(911983054) DBG 22.001539872 gptp md_pdelay_req_compute_prop_time : Port(0): r 1.0000000000000000 t1(22001055234) t2(3930911776943) t3(3930911983054) t4(22001275190) t4-t1(219956) t3-t2(206111) DBG 22.001539872 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay 6922.50 ns (6922.50 ns) DBG 22.001539872 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_RESP_FOLLOW_UP event FUP_RECEIVED new state WAITING_FOR_PDELAY_INTERVAL_TIMER DBG 22.001845896 gptp gptp_dump_header : msg_type SYNC DBG 22.001845896 gptp gptp_dump_header : transport_specific 1 DBG 22.001845896 gptp gptp_dump_header : version_ptp 2 DBG 22.001845896 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.001845896 gptp gptp_dump_header : msg_length 44 DBG 22.001845896 gptp gptp_dump_header : domain_number 0 DBG 22.001845896 gptp gptp_dump_header : flags 0x200 DBG 22.001845896 gptp gptp_dump_header : correction_field 0 DBG 22.001845896 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.001845896 gptp gptp_dump_header : port_number 1 DBG 22.001845896 gptp gptp_dump_header : sequence_id 22920 DBG 22.001845896 gptp gptp_dump_header : control 0 DBG 22.001845896 gptp gptp_dump_header : log_msg_interval -3 DBG 22.001845896 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22055058966 DBG 22.001845896 gptp gptp_handle_sync : Port(0): seq_id=22920 INFO 22.001845896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.001845896 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.055344296 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.055344296 gptp gptp_dump_header : transport_specific 1 DBG 22.055344296 gptp gptp_dump_header : version_ptp 2 DBG 22.055344296 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.055344296 gptp gptp_dump_header : msg_length 76 DBG 22.055344296 gptp gptp_dump_header : domain_number 0 DBG 22.055344296 gptp gptp_dump_header : flags 0x00 DBG 22.055344296 gptp gptp_dump_header : correction_field 0 DBG 22.055344296 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.055344296 gptp gptp_dump_header : port_number 1 DBG 22.055344296 gptp gptp_dump_header : sequence_id 22920 DBG 22.055344296 gptp gptp_dump_header : control 0 DBG 22.055344296 gptp gptp_dump_header : log_msg_interval -3 DBG 22.055344296 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22055208014 DBG 22.055344296 gptp gptp_handle_follow_up : Port(0): seq_id=22920 DBG 22.055344296 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.055344296 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.055515952 gptp gptp_dump_header : msg_type SYNC DBG 22.055515952 gptp gptp_dump_header : transport_specific 1 DBG 22.055515952 gptp gptp_dump_header : version_ptp 2 DBG 22.055515952 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.055515952 gptp gptp_dump_header : msg_length 44 DBG 22.055515952 gptp gptp_dump_header : domain_number 0 DBG 22.055515952 gptp gptp_dump_header : flags 0x200 DBG 22.055515952 gptp gptp_dump_header : correction_field 0 DBG 22.055515952 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.055515952 gptp gptp_dump_header : port_number 1 DBG 22.055515952 gptp gptp_dump_header : sequence_id 22921 DBG 22.055515952 gptp gptp_dump_header : control 0 DBG 22.055515952 gptp gptp_dump_header : log_msg_interval -3 DBG 22.055515952 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22180207790 DBG 22.055515952 gptp gptp_handle_sync : Port(0): seq_id=22921 INFO 22.055515952 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.055515952 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.180394800 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.180394800 gptp gptp_dump_header : transport_specific 1 DBG 22.180394800 gptp gptp_dump_header : version_ptp 2 DBG 22.180394800 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.180394800 gptp gptp_dump_header : msg_length 76 DBG 22.180394800 gptp gptp_dump_header : domain_number 0 DBG 22.180394800 gptp gptp_dump_header : flags 0x00 DBG 22.180394800 gptp gptp_dump_header : correction_field 0 DBG 22.180394800 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.180394800 gptp gptp_dump_header : port_number 1 DBG 22.180394800 gptp gptp_dump_header : sequence_id 22921 DBG 22.180394800 gptp gptp_dump_header : control 0 DBG 22.180394800 gptp gptp_dump_header : log_msg_interval -3 DBG 22.180394800 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22180334622 DBG 22.180394800 gptp gptp_handle_follow_up : Port(0): seq_id=22921 DBG 22.180394800 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.180394800 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.180561896 gptp gptp_dump_header : msg_type SYNC DBG 22.180561896 gptp gptp_dump_header : transport_specific 1 DBG 22.180561896 gptp gptp_dump_header : version_ptp 2 DBG 22.180561896 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.180561896 gptp gptp_dump_header : msg_length 44 DBG 22.180561896 gptp gptp_dump_header : domain_number 0 DBG 22.180561896 gptp gptp_dump_header : flags 0x200 DBG 22.180561896 gptp gptp_dump_header : correction_field 0 DBG 22.180561896 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.180561896 gptp gptp_dump_header : port_number 1 DBG 22.180561896 gptp gptp_dump_header : sequence_id 22922 DBG 22.180561896 gptp gptp_dump_header : control 0 DBG 22.180561896 gptp gptp_dump_header : log_msg_interval -3 DBG 22.180561896 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22305698350 DBG 22.180561896 gptp gptp_handle_sync : Port(0): seq_id=22922 INFO 22.180561896 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.180561896 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.305935248 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.305935248 gptp gptp_dump_header : transport_specific 1 DBG 22.305935248 gptp gptp_dump_header : version_ptp 2 DBG 22.305935248 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.305935248 gptp gptp_dump_header : msg_length 76 DBG 22.305935248 gptp gptp_dump_header : domain_number 0 DBG 22.305935248 gptp gptp_dump_header : flags 0x00 DBG 22.305935248 gptp gptp_dump_header : correction_field 0 DBG 22.305935248 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.305935248 gptp gptp_dump_header : port_number 1 DBG 22.305935248 gptp gptp_dump_header : sequence_id 22922 DBG 22.305935248 gptp gptp_dump_header : control 0 DBG 22.305935248 gptp gptp_dump_header : log_msg_interval -3 DBG 22.305935248 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22305800734 DBG 22.305935248 gptp gptp_handle_follow_up : Port(0): seq_id=22922 DBG 22.305935248 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.305935248 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.306102376 gptp gptp_dump_header : msg_type SYNC DBG 22.306102376 gptp gptp_dump_header : transport_specific 1 DBG 22.306102376 gptp gptp_dump_header : version_ptp 2 DBG 22.306102376 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.306102376 gptp gptp_dump_header : msg_length 44 DBG 22.306102376 gptp gptp_dump_header : domain_number 0 DBG 22.306102376 gptp gptp_dump_header : flags 0x200 DBG 22.306102376 gptp gptp_dump_header : correction_field 0 DBG 22.306102376 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.306102376 gptp gptp_dump_header : port_number 1 DBG 22.306102376 gptp gptp_dump_header : sequence_id 22923 DBG 22.306102376 gptp gptp_dump_header : control 0 DBG 22.306102376 gptp gptp_dump_header : log_msg_interval -3 DBG 22.306102376 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22431188286 DBG 22.306102376 gptp gptp_handle_sync : Port(0): seq_id=22923 INFO 22.306102376 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.306102376 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.306102376 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.306102376 gptp gptp_dump_header : transport_specific 1 DBG 22.306102376 gptp gptp_dump_header : version_ptp 2 DBG 22.306102376 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.306102376 gptp gptp_dump_header : msg_length 76 DBG 22.306102376 gptp gptp_dump_header : domain_number 0 DBG 22.306102376 gptp gptp_dump_header : flags 0x00 DBG 22.306102376 gptp gptp_dump_header : correction_field 0 DBG 22.306102376 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.306102376 gptp gptp_dump_header : port_number 1 DBG 22.306102376 gptp gptp_dump_header : sequence_id 22923 DBG 22.306102376 gptp gptp_dump_header : control 0 DBG 22.306102376 gptp gptp_dump_header : log_msg_interval -3 DBG 22.306102376 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22431277918 DBG 22.306102376 gptp gptp_handle_follow_up : Port(0): seq_id=22923 DBG 22.306102376 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.306102376 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.431654600 gptp gptp_dump_header : msg_type SYNC DBG 22.431654600 gptp gptp_dump_header : transport_specific 1 DBG 22.431654600 gptp gptp_dump_header : version_ptp 2 DBG 22.431654600 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.431654600 gptp gptp_dump_header : msg_length 44 DBG 22.431654600 gptp gptp_dump_header : domain_number 0 DBG 22.431654600 gptp gptp_dump_header : flags 0x200 DBG 22.431654600 gptp gptp_dump_header : correction_field 0 DBG 22.431654600 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.431654600 gptp gptp_dump_header : port_number 1 DBG 22.431654600 gptp gptp_dump_header : sequence_id 22924 DBG 22.431654600 gptp gptp_dump_header : control 0 DBG 22.431654600 gptp gptp_dump_header : log_msg_interval -3 DBG 22.431654600 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22556667726 DBG 22.431654600 gptp gptp_handle_sync : Port(0): seq_id=22924 INFO 22.431654600 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.431654600 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.556911776 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.556911776 gptp gptp_dump_header : transport_specific 1 DBG 22.556911776 gptp gptp_dump_header : version_ptp 2 DBG 22.556911776 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.556911776 gptp gptp_dump_header : msg_length 76 DBG 22.556911776 gptp gptp_dump_header : domain_number 0 DBG 22.556911776 gptp gptp_dump_header : flags 0x00 DBG 22.556911776 gptp gptp_dump_header : correction_field 0 DBG 22.556911776 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.556911776 gptp gptp_dump_header : port_number 1 DBG 22.556911776 gptp gptp_dump_header : sequence_id 22924 DBG 22.556911776 gptp gptp_dump_header : control 0 DBG 22.556911776 gptp gptp_dump_header : log_msg_interval -3 DBG 22.556911776 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22556849886 DBG 22.556911776 gptp gptp_handle_follow_up : Port(0): seq_id=22924 DBG 22.556911776 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.556911776 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.557079352 gptp gptp_dump_header : msg_type SYNC DBG 22.557079352 gptp gptp_dump_header : transport_specific 1 DBG 22.557079352 gptp gptp_dump_header : version_ptp 2 DBG 22.557079352 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.557079352 gptp gptp_dump_header : msg_length 44 DBG 22.557079352 gptp gptp_dump_header : domain_number 0 DBG 22.557079352 gptp gptp_dump_header : flags 0x200 DBG 22.557079352 gptp gptp_dump_header : correction_field 0 DBG 22.557079352 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.557079352 gptp gptp_dump_header : port_number 1 DBG 22.557079352 gptp gptp_dump_header : sequence_id 22925 DBG 22.557079352 gptp gptp_dump_header : control 0 DBG 22.557079352 gptp gptp_dump_header : log_msg_interval -3 DBG 22.557079352 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22681784750 DBG 22.557079352 gptp gptp_handle_sync : Port(0): seq_id=22925 INFO 22.557079352 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.557079352 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.557079352 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.557079352 gptp gptp_dump_header : transport_specific 1 DBG 22.557079352 gptp gptp_dump_header : version_ptp 2 DBG 22.557079352 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.557079352 gptp gptp_dump_header : msg_length 76 DBG 22.557079352 gptp gptp_dump_header : domain_number 0 DBG 22.557079352 gptp gptp_dump_header : flags 0x00 DBG 22.557079352 gptp gptp_dump_header : correction_field 0 DBG 22.557079352 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.557079352 gptp gptp_dump_header : port_number 1 DBG 22.557079352 gptp gptp_dump_header : sequence_id 22925 DBG 22.557079352 gptp gptp_dump_header : control 0 DBG 22.557079352 gptp gptp_dump_header : log_msg_interval -3 DBG 22.557079352 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22681852470 DBG 22.557079352 gptp gptp_handle_follow_up : Port(0): seq_id=22925 DBG 22.557079352 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.557079352 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.682234424 gptp gptp_dump_header : msg_type ANNOUNCE DBG 22.682234424 gptp gptp_dump_header : transport_specific 1 DBG 22.682234424 gptp gptp_dump_header : version_ptp 2 DBG 22.682234424 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.682234424 gptp gptp_dump_header : msg_length 76 DBG 22.682234424 gptp gptp_dump_header : domain_number 0 DBG 22.682234424 gptp gptp_dump_header : flags 0x08 DBG 22.682234424 gptp gptp_dump_header : correction_field 0 DBG 22.682234424 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.682234424 gptp gptp_dump_header : port_number 1 DBG 22.682234424 gptp gptp_dump_header : sequence_id 2880 DBG 22.682234424 gptp gptp_dump_header : control 0 DBG 22.682234424 gptp gptp_dump_header : log_msg_interval 0 DBG 22.682234424 gptp gptp_instance_net_rx : Port(0) domain(0, 0): ANNOUNCE desc port 0, len 90, ts 22769288374 DBG 22.682234424 gptp gptp_handle_announce : Port(0): seq_id=2880 DBG 22.682234424 gptp gptp_dump_announcer_params : gm identity b49691fffe8c899e DBG 22.682234424 gptp gptp_dump_announcer_params : priority1 248 priority2 248 DBG 22.682234424 gptp gptp_dump_announcer_params : class 248 accuracy 254 DBG 22.682234424 gptp gptp_dump_announcer_params : steps_removed 0 DBG 22.769515752 gptp gptp_dump_header : msg_type SYNC DBG 22.769515752 gptp gptp_dump_header : transport_specific 1 DBG 22.769515752 gptp gptp_dump_header : version_ptp 2 DBG 22.769515752 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.769515752 gptp gptp_dump_header : msg_length 44 DBG 22.769515752 gptp gptp_dump_header : domain_number 0 DBG 22.769515752 gptp gptp_dump_header : flags 0x200 DBG 22.769515752 gptp gptp_dump_header : correction_field 0 DBG 22.769515752 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.769515752 gptp gptp_dump_header : port_number 1 DBG 22.769515752 gptp gptp_dump_header : sequence_id 22926 DBG 22.769515752 gptp gptp_dump_header : control 0 DBG 22.769515752 gptp gptp_dump_header : log_msg_interval -3 DBG 22.769515752 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22807263710 DBG 22.769515752 gptp gptp_handle_sync : Port(0): seq_id=22926 INFO 22.769515752 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.769515752 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.807482920 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.807482920 gptp gptp_dump_header : transport_specific 1 DBG 22.807482920 gptp gptp_dump_header : version_ptp 2 DBG 22.807482920 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.807482920 gptp gptp_dump_header : msg_length 76 DBG 22.807482920 gptp gptp_dump_header : domain_number 0 DBG 22.807482920 gptp gptp_dump_header : flags 0x00 DBG 22.807482920 gptp gptp_dump_header : correction_field 0 DBG 22.807482920 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.807482920 gptp gptp_dump_header : port_number 1 DBG 22.807482920 gptp gptp_dump_header : sequence_id 22926 DBG 22.807482920 gptp gptp_dump_header : control 0 DBG 22.807482920 gptp gptp_dump_header : log_msg_interval -3 DBG 22.807482920 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22807405790 DBG 22.807482920 gptp gptp_handle_follow_up : Port(0): seq_id=22926 DBG 22.807482920 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.807482920 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.807656920 gptp gptp_dump_header : msg_type SYNC DBG 22.807656920 gptp gptp_dump_header : transport_specific 1 DBG 22.807656920 gptp gptp_dump_header : version_ptp 2 DBG 22.807656920 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.807656920 gptp gptp_dump_header : msg_length 44 DBG 22.807656920 gptp gptp_dump_header : domain_number 0 DBG 22.807656920 gptp gptp_dump_header : flags 0x200 DBG 22.807656920 gptp gptp_dump_header : correction_field 0 DBG 22.807656920 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.807656920 gptp gptp_dump_header : port_number 1 DBG 22.807656920 gptp gptp_dump_header : sequence_id 22927 DBG 22.807656920 gptp gptp_dump_header : control 0 DBG 22.807656920 gptp gptp_dump_header : log_msg_interval -3 DBG 22.807656920 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 22932785774 DBG 22.807656920 gptp gptp_handle_sync : Port(0): seq_id=22927 INFO 22.807656920 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 22.807656920 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 22.933026720 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 22.933026720 gptp gptp_dump_header : transport_specific 1 DBG 22.933026720 gptp gptp_dump_header : version_ptp 2 DBG 22.933026720 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.933026720 gptp gptp_dump_header : msg_length 76 DBG 22.933026720 gptp gptp_dump_header : domain_number 0 DBG 22.933026720 gptp gptp_dump_header : flags 0x00 DBG 22.933026720 gptp gptp_dump_header : correction_field 0 DBG 22.933026720 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.933026720 gptp gptp_dump_header : port_number 1 DBG 22.933026720 gptp gptp_dump_header : sequence_id 22927 DBG 22.933026720 gptp gptp_dump_header : control 0 DBG 22.933026720 gptp gptp_dump_header : log_msg_interval -3 DBG 22.933026720 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 22932916006 DBG 22.933026720 gptp gptp_handle_follow_up : Port(0): seq_id=22927 DBG 22.933026720 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 22.933026720 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 22.933194024 gptp gptp_dump_header : msg_type PDELAY_REQ DBG 22.933194024 gptp gptp_dump_header : transport_specific 1 DBG 22.933194024 gptp gptp_dump_header : version_ptp 2 DBG 22.933194024 gptp gptp_dump_header : minor_version_ptp 1 DBG 22.933194024 gptp gptp_dump_header : msg_length 54 DBG 22.933194024 gptp gptp_dump_header : domain_number 0 DBG 22.933194024 gptp gptp_dump_header : flags 0x00 DBG 22.933194024 gptp gptp_dump_header : correction_field 0 DBG 22.933194024 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 22.933194024 gptp gptp_dump_header : port_number 1 DBG 22.933194024 gptp gptp_dump_header : sequence_id 2953 DBG 22.933194024 gptp gptp_dump_header : control 0 DBG 22.933194024 gptp gptp_dump_header : log_msg_interval 0 DBG 22.933194024 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_REQ desc port 0, len 68, ts 22970999726 DBG 22.933194024 gptp gptp_handle_pdelay_req : Port(0): seq_id=2953 ts 22970999726 DBG 22.933194024 gptp md_set_pdelay_resp : Port(0) DBG 22.933194024 gptp gptp_net_tx : Port(0): PDELAY_RESP len 54 sdoid 1 DBG 22.933194024 gptp gptp_dump_header : msg_type PDELAY_RESP DBG 22.933194024 gptp gptp_dump_header : transport_specific 1 DBG 22.933194024 gptp gptp_dump_header : version_ptp 2 DBG 22.933194024 gptp gptp_dump_header : minor_version_ptp 0 DBG 22.933194024 gptp gptp_dump_header : msg_length 54 DBG 22.933194024 gptp gptp_dump_header : domain_number 0 DBG 22.933194024 gptp gptp_dump_header : flags 0x208 DBG 22.933194024 gptp gptp_dump_header : correction_field 0 DBG 22.933194024 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 22.933194024 gptp gptp_dump_header : port_number 1 DBG 22.933194024 gptp gptp_dump_header : sequence_id 2953 DBG 22.933194024 gptp gptp_dump_header : control 5 DBG 22.933194024 gptp gptp_dump_header : log_msg_interval 127 DBG 22.933194024 gptp gptp_net_tx : Port(0): ts_required - desc->priv 0x01000003 DBG 22.933194024 gptp md_pdelay_resp_sm : Port(0): state WAITING_FOR_PDELAY_REQ event REQ_RECEIVED new state SENT_PDELAY_RESP_WAITING_FOR_TIMESTAMP DBG 22.971403000 gptp gptp_instance_hwts_handler : Port(0) domain(0, 0): ts 22971390162, type 3 PDELAY_RESP DBG 22.971403000 gptp md_set_pdelay_resp_fup : Port(0): ts 22971390162 DBG 22.971403000 gptp gptp_net_tx : Port(0): PDELAY_RESP_FUP len 54 sdoid 1 DBG 22.971403000 gptp gptp_dump_header : msg_type PDELAY_RESP_FUP DBG 22.971403000 gptp gptp_dump_header : transport_specific 1 DBG 22.971403000 gptp gptp_dump_header : version_ptp 2 DBG 22.971403000 gptp gptp_dump_header : minor_version_ptp 0 DBG 22.971403000 gptp gptp_dump_header : msg_length 54 DBG 22.971403000 gptp gptp_dump_header : domain_number 0 DBG 22.971403000 gptp gptp_dump_header : flags 0x08 DBG 22.971403000 gptp gptp_dump_header : correction_field 0 DBG 22.971403000 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 22.971403000 gptp gptp_dump_header : port_number 1 DBG 22.971403000 gptp gptp_dump_header : sequence_id 2953 DBG 22.971403000 gptp gptp_dump_header : control 5 DBG 22.971403000 gptp gptp_dump_header : log_msg_interval 127 DBG 22.971403000 gptp md_pdelay_resp_sm : Port(0): state SENT_PDELAY_RESP_WAITING_FOR_TIMESTAMP event TIMESTAMP_RECEIVED new state WAITING_FOR_PDELAY_REQ DBG 22.971669920 gptp site_sync_sync_sm : state INITIALIZING event PSSYNC RECEIVED new state INITIALIZING DBG 22.971669920 gptp clock_master_sync_send_sm : state SYNC INDICATION event INTERVAL new state SYNC INDICATION DBG 23.000863296 gptp clock_master_sync_send_sm : state INITIALIZING event INTERVAL new state INITIALIZING DBG 23.000885672 gptp gptp_pdelay_req_timer_handler : Port(0) DBG 23.000885672 gptp md_pdelay_req_sm : Port(0): pdelay timing: req_to_ts 87 (min 21 max 111) us req_to_resp 472 us req_to_fup 634 us DBG 23.000885672 gptp md_set_pdelay_req : Port(0) DBG 23.000885672 gptp gptp_net_tx : Port(0): PDELAY_REQ len 54 sdoid 1 DBG 23.000885672 gptp gptp_dump_header : msg_type PDELAY_REQ DBG 23.000885672 gptp gptp_dump_header : transport_specific 1 DBG 23.000885672 gptp gptp_dump_header : version_ptp 2 DBG 23.000885672 gptp gptp_dump_header : minor_version_ptp 0 DBG 23.000885672 gptp gptp_dump_header : msg_length 54 DBG 23.000885672 gptp gptp_dump_header : domain_number 0 DBG 23.000885672 gptp gptp_dump_header : flags 0x08 DBG 23.000885672 gptp gptp_dump_header : correction_field 0 DBG 23.000885672 gptp gptp_dump_header : clock_identity 0x00bbccfffeddee10 DBG 23.000885672 gptp gptp_dump_header : port_number 1 DBG 23.000885672 gptp gptp_dump_header : sequence_id 24 DBG 23.000885672 gptp gptp_dump_header : control 5 DBG 23.000885672 gptp gptp_dump_header : log_msg_interval 0 DBG 23.000885672 gptp gptp_net_tx : Port(0): ts_required - desc->priv 0x01000002 DBG 23.000885672 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_INTERVAL_TIMER event REQ_INTERVAL new state SEND_PDELAY_REQ DBG 23.001072120 gptp gptp_instance_hwts_handler : Port(0) domain(0, 0): ts 23001056482, type 2 PDELAY_REQ DBG 23.001072120 gptp md_pdelay_req_sm : Port(0): event TIMESTAMP_RECEIVED received (req_to_ts 81 us) DBG 23.001072120 gptp md_pdelay_req_sm : Port(0): s 1 state SEND_PDELAY_REQ event TIMESTAMP_RECEIVED new state WAITING_FOR_PDELAY_RESP DBG 23.001160376 gptp gptp_dump_header : msg_type PDELAY_RESP DBG 23.001160376 gptp gptp_dump_header : transport_specific 1 DBG 23.001160376 gptp gptp_dump_header : version_ptp 2 DBG 23.001160376 gptp gptp_dump_header : minor_version_ptp 1 DBG 23.001160376 gptp gptp_dump_header : msg_length 54 DBG 23.001160376 gptp gptp_dump_header : domain_number 0 DBG 23.001160376 gptp gptp_dump_header : flags 0x200 DBG 23.001160376 gptp gptp_dump_header : correction_field 0 DBG 23.001160376 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 23.001160376 gptp gptp_dump_header : port_number 1 DBG 23.001160376 gptp gptp_dump_header : sequence_id 24 DBG 23.001160376 gptp gptp_dump_header : control 0 DBG 23.001160376 gptp gptp_dump_header : log_msg_interval 127 DBG 23.001160376 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_RESP desc port 0, len 68, ts 23001227262 DBG 23.001160376 gptp gptp_handle_pdelay_resp : Port(0): seq_id=24 ts 23001227262 correction 0 DBG 23.001160376 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_RESP event RESP_RECEIVED new state WAITING_FOR_PDELAY_RESP_FOLLOW_UP DBG 23.001517096 gptp gptp_dump_header : msg_type PDELAY_RESP_FUP DBG 23.001517096 gptp gptp_dump_header : transport_specific 1 DBG 23.001517096 gptp gptp_dump_header : version_ptp 2 DBG 23.001517096 gptp gptp_dump_header : minor_version_ptp 1 DBG 23.001517096 gptp gptp_dump_header : msg_length 54 DBG 23.001517096 gptp gptp_dump_header : domain_number 0 DBG 23.001517096 gptp gptp_dump_header : flags 0x00 DBG 23.001517096 gptp gptp_dump_header : correction_field 0 DBG 23.001517096 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 23.001517096 gptp gptp_dump_header : port_number 1 DBG 23.001517096 gptp gptp_dump_header : sequence_id 24 DBG 23.001517096 gptp gptp_dump_header : control 0 DBG 23.001517096 gptp gptp_dump_header : log_msg_interval 127 DBG 23.001517096 gptp gptp_instance_net_rx : Port(0) domain(0, 0): PDELAY_RESP_FUP desc port 0, len 68, ts 23001359014 DBG 23.001517096 gptp gptp_handle_pdelay_resp_fup : Port(0): seq_id=24 sec_msb 0 sec_lsb 1527709696 ns 3254689330 correction 0 DBG 23.001517096 gptp md_pdelay_req_compute_pdelay_rat : Port(0) ERR 23.001517096 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 0.9373425759549804 ignored DBG 23.001517096 gptp md_pdelay_req_compute_pdelay_rat : Port(0): prev_pdelay_response_event_ingress_timestamp(22001275190) prev_corrected_responder_event_timestamp(3930911983054) DBG 23.001517096 gptp md_pdelay_req_compute_pdelay_rat : Port(0): pdelay_response_event_ingress_timestamp(23001227262) corrected_responder_event_timestamp(3931849280705) DBG 23.001517096 gptp md_pdelay_req_compute_pdelay_rat : Port(0): NeighborRateRatio 1.0000000000000000 (0 ppb) DBG 23.001517096 gptp md_pdelay_req_compute_prop_time : Port(0) DBG 23.001517096 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay request_receipt_timestamp: secs msb(0) secs lsb(3931) nsecs(849120689) DBG 23.001517096 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay response_origin_timestamp: secs msb(0) secs lsb(3931) nsecs(849280705) DBG 23.001517096 gptp md_pdelay_req_compute_prop_time : Port(0): r 1.0000000000000000 t1(23001056482) t2(3931849120689) t3(3931849280705) t4(23001227262) t4-t1(170780) t3-t2(160016) DBG 23.001517096 gptp md_pdelay_req_compute_prop_time : Port(0): PDelay 5382.00 ns (5382.00 ns) DBG 23.001517096 gptp md_pdelay_req_sm : Port(0): s 1 state WAITING_FOR_PDELAY_RESP_FOLLOW_UP event FUP_RECEIVED new state WAITING_FOR_PDELAY_INTERVAL_TIMER DBG 23.001824800 gptp gptp_dump_header : msg_type SYNC DBG 23.001824800 gptp gptp_dump_header : transport_specific 1 DBG 23.001824800 gptp gptp_dump_header : version_ptp 2 DBG 23.001824800 gptp gptp_dump_header : minor_version_ptp 1 DBG 23.001824800 gptp gptp_dump_header : msg_length 44 DBG 23.001824800 gptp gptp_dump_header : domain_number 0 DBG 23.001824800 gptp gptp_dump_header : flags 0x200 DBG 23.001824800 gptp gptp_dump_header : correction_field 0 DBG 23.001824800 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 23.001824800 gptp gptp_dump_header : port_number 1 DBG 23.001824800 gptp gptp_dump_header : sequence_id 22928 DBG 23.001824800 gptp gptp_dump_header : control 0 DBG 23.001824800 gptp gptp_dump_header : log_msg_interval -3 DBG 23.001824800 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 23058287150 DBG 23.001824800 gptp gptp_handle_sync : Port(0): seq_id=22928 INFO 23.001824800 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 23.001824800 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 23.058556320 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 23.058556320 gptp gptp_dump_header : transport_specific 1 DBG 23.058556320 gptp gptp_dump_header : version_ptp 2 DBG 23.058556320 gptp gptp_dump_header : minor_version_ptp 1 DBG 23.058556320 gptp gptp_dump_header : msg_length 76 DBG 23.058556320 gptp gptp_dump_header : domain_number 0 DBG 23.058556320 gptp gptp_dump_header : flags 0x00 DBG 23.058556320 gptp gptp_dump_header : correction_field 0 DBG 23.058556320 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 23.058556320 gptp gptp_dump_header : port_number 1 DBG 23.058556320 gptp gptp_dump_header : sequence_id 22928 DBG 23.058556320 gptp gptp_dump_header : control 0 DBG 23.058556320 gptp gptp_dump_header : log_msg_interval -3 DBG 23.058556320 gptp gptp_instance_net_rx : Port(0) domain(0, 0): FOLLOW_UP desc port 0, len 90, ts 23058427654 DBG 23.058556320 gptp gptp_handle_follow_up : Port(0): seq_id=22928 DBG 23.058556320 gptp md_sync_rcv_sm : Port(0): state DISCARD event FUP_RECEIVED new state DISCARD DBG 23.058556320 gptp gptp_handle_follow_up : Port(0): rsync 0 interval 112 state 0 rsync_running 0 DBG 23.058722320 gptp gptp_dump_header : msg_type SYNC DBG 23.058722320 gptp gptp_dump_header : transport_specific 1 DBG 23.058722320 gptp gptp_dump_header : version_ptp 2 DBG 23.058722320 gptp gptp_dump_header : minor_version_ptp 1 DBG 23.058722320 gptp gptp_dump_header : msg_length 44 DBG 23.058722320 gptp gptp_dump_header : domain_number 0 DBG 23.058722320 gptp gptp_dump_header : flags 0x200 DBG 23.058722320 gptp gptp_dump_header : correction_field 0 DBG 23.058722320 gptp gptp_dump_header : clock_identity 0xb49691fffe8c899e DBG 23.058722320 gptp gptp_dump_header : port_number 1 DBG 23.058722320 gptp gptp_dump_header : sequence_id 22929 DBG 23.058722320 gptp gptp_dump_header : control 0 DBG 23.058722320 gptp gptp_dump_header : log_msg_interval -3 DBG 23.058722320 gptp gptp_instance_net_rx : Port(0) domain(0, 0): SYNC desc port 0, len 60, ts 23183648374 DBG 23.058722320 gptp gptp_handle_sync : Port(0): seq_id=22929 INFO 23.058722320 gptp md_sync_rcv_sm : Port(0): resetting upon link not ready (state DISCARD - 1 1 0) DBG 23.058722320 gptp md_sync_rcv_sm : Port(0): state DISCARD event SYNC_RECEIVED new state DISCARD DBG 23.183850048 gptp gptp_dump_header : msg_type FOLLOW_UP DBG 23.1838