[REGISTRY] WARNING: Attempting to overwrite previously registered RFNoC block with noc_id,device_id: 0xb16, 0xffff Creating the RFNoC graph with args: ... [INFO] [UHD] linux; GNU C++ version 9.4.0; Boost_107100; UHD_4.6.0.0-141-g0f2007fc [TRACE] [MPMD FIND] Finding with 1 different hint(s). [TRACE] [MPMD FIND] Broadcasting on all available interfaces to find MPM devices. [DEBUG] [MPMD] Discovering MPM devices on port 49600 [TRACE] [UDP] Creating udp transport for 127.255.255.255 49600 [DEBUG] [MPMD] Discovering MPM devices on port 49600 [TRACE] [UDP] Creating udp transport for 192.168.11.255 49600 [DEBUG] [MPMD] Discovering MPM devices on port 49600 [TRACE] [UDP] Creating udp transport for 192.168.0.255 49600 [DEBUG] [MPMD] Discovering MPM devices on port 49600 [TRACE] [UDP] Creating udp transport for 192.168.91.255 49600 [DEBUG] [MPMD] Discovering MPM devices on port 49600 [TRACE] [UDP] Creating udp transport for 172.17.255.255 49600 [DEBUG] [MPMD] Discovering MPM devices on port 49600 [TRACE] [UDP] Creating udp transport for 192.168.111.255 49600 [TRACE] [MPMD FIND] Found device that matches hints: mgmt_addr=192.168.0.15,type=x4xx,product=x410,serial=323F755,name=ni-x4xx-323F755,fpga=X4_200,claimed=False [TRACE] [MPMD FIND] Found 1 device via broadcast. [TRACE] [MPMD] Checking accessibility of device `mgmt_addr=192.168.0.15,type=x4xx,product=x410,serial=323F755,name=ni-x4xx-323F755,fpga=X4_200,claimed=False' [TRACE] [MPMD] Checking reachability via network addr 192.168.11.2 [TRACE] [UDP] Creating udp transport for 192.168.11.2 49600 [TRACE] [MPMD] Was able to ping device, trying RPC connection. [TRACE] [MPMD] Reachable device matches expected device (serial=323F755) [TRACE] [UDP] Creating udp transport for 192.168.11.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.0.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.91.255 49152 [TRACE] [UDP] Creating udp transport for 172.17.255.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.111.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.11.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.0.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.91.255 49152 [TRACE] [UDP] Creating udp transport for 172.17.255.255 49152 [TRACE] [UDP] Creating udp transport for 192.168.111.255 49152 [TRACE] [NIRIO] rpc_client connection request cancelled/aborted. [TRACE] [UDP] Creating udp transport for 192.168.11.255 50000 [TRACE] [UDP] Creating udp transport for 192.168.0.255 50000 [TRACE] [UDP] Creating udp transport for 192.168.91.255 50000 [TRACE] [UDP] Creating udp transport for 172.17.255.255 50000 [TRACE] [UDP] Creating udp transport for 192.168.111.255 50000 [TRACE] [UHD] Device hash: 10564926927416495515 [TRACE] [CONF] Initializing config file object... [TRACE] [PREFS] Trying to load /etc/uhd/uhd.conf [DEBUG] [PREFS] Loaded system config file /etc/uhd/uhd.conf [TRACE] [PREFS] Trying to load /home/user/.config/uhd.conf [TRACE] [PREFS] No user config file found at /home/user/.config/uhd.conf [TRACE] [PREFS] Trying to load /home/user/.uhd/uhd.conf [TRACE] [PREFS] No user config file found at /home/user/.uhd/uhd.conf [TRACE] [PREFS] Done initializing. [INFO] [MPMD] Initializing 1 device(s) in parallel with args: mgmt_addr=192.168.0.15,type=x4xx,product=x410,serial=323F755,name=ni-x4xx-323F755,fpga=X4_200,claimed=False,addr=192.168.11.2 [DEBUG] [MPMD] Claiming mboard 0 [DEBUG] [MPMD] Device args: `mgmt_addr=192.168.0.15,type=x4xx,product=x410,serial=323F755,name=ni-x4xx-323F755,fpga=X4_200,claimed=False,addr=192.168.11.2'. RPC address: 192.168.0.15 [TRACE] [MPMD] Initializing mboard, connecting to RPC server address: 192.168.0.15 mboard args: mgmt_addr=192.168.0.15,type=x4xx,product=x410,serial=323F755,name=ni-x4xx-323F755,fpga=X4_200,claimed=False,addr=192.168.11.2 [TRACE] [MPMD] Received claim token KTem3G39a0fyzZYQ [DEBUG] [MPMD] MPM reports device info: addr=192.168.11.2,claimed=True,connection=remote,dboard_0_pid=16386,dboard_0_serial=32867DE,dboard_1_pid=16386,dboard_1_serial=3278173,description=X400-Series Device,eeprom_version=,fourth_addr=192.168.0.15,fpga=X4_200,fpga_version=8.2,fpga_version_hash=19f5951.dirty,fs_version=20240430060608,mender_artifact=v4.6.0.0_x4xx,mpm_sw_version=4.6.0.0-g50fa3baa,mpm_version=5.3,name=ni-x4xx-323F755,pid=1040,product=x410,rev=7,rpc_connection=remote,serial=323F755,type=x4xx [TRACE] [MPMD] MPM reports dboard info for slot 0: eeprom_version=n/a,pid=16386,rev=3,serial=32867DE [TRACE] [MPMD] MPM reports dboard info for slot 1: eeprom_version=n/a,pid=16386,rev=3,serial=3278173 [TRACE] [MPMD::MB_IFACE] Assigning device_id 1 [DEBUG] [MPMD] Found 16 motherboard sensors. [TRACE] [MPMD] Checking MPM compat number. Expected: 5.3 Actual: 5.3 [DEBUG] [MPMD] Initializing mboard 0 [INFO] [MPM.PeriphManager] init() called with device args `fpga=X4_200,mgmt_addr=192.168.0.15,name=ni-x4xx-323F755,product=x410,clock_source=internal,time_source=internal,initializing=True'. [TRACE] [MPMD::MB_IFACE] Requesting clock ifaces... [DEBUG] [MPMD::MB_IFACE] Adding clock iface `ctrl_clk`, frequency: 40 MHz, mutable: No [DEBUG] [MPMD::MB_IFACE] Adding clock iface `1`, frequency: 40 MHz, mutable: No [DEBUG] [MPMD::MB_IFACE] Adding clock iface `bus_clk`, frequency: 200 MHz, mutable: No [DEBUG] [MPMD::MB_IFACE] Adding clock iface `chdr_clk`, frequency: 200 MHz, mutable: No [DEBUG] [MPMD::MB_IFACE] Adding clock iface `2`, frequency: 200 MHz, mutable: No [DEBUG] [MPMD::MB_IFACE] Adding clock iface `3`, frequency: 266.667 MHz, mutable: No [DEBUG] [MPMD::MB_IFACE] Adding clock iface `radio_clk`, frequency: 245.76 MHz, mutable: Yes [DEBUG] [MPMD::MB_IFACE] Adding clock iface `4`, frequency: 245.76 MHz, mutable: Yes [DEBUG] [MPMD::MB_IFACE] Adding clock iface `5`, frequency: 245.76 MHz, mutable: Yes [TRACE] [MPMD::MB_IFACE] Requesting CHDR link types... [TRACE] [MPMD::MB_IFACE] Found 1 link type(s) [TRACE] [MPMD::MB_IFACE] Trying link type `udp' [TRACE] [UDP] Creating udp transport for 192.168.11.2 49600 [TRACE] [MPMD] Determining UDP MTU... [TRACE] [MPMD] Testing frame size 4284 [TRACE] [MPMD] Testing frame size 2416 [TRACE] [MPMD] Testing frame size 1480 [TRACE] [MPMD] Testing frame size 1948 [TRACE] [MPMD] Testing frame size 1712 [TRACE] [MPMD] Testing frame size 1596 [TRACE] [MPMD] Testing frame size 1536 [TRACE] [MPMD] Testing frame size 1508 [TRACE] [MPMD] Testing frame size 1492 [TRACE] [MPMD] Testing frame size 1484 [TRACE] [MPMD] Testing frame size 1488 [DEBUG] [MPMD] MTU discovery detected 1488 bytes. This may be due to a faulty MTU discovery. Coercing to 1472 bytes. [DEBUG] [MPMD] Path MTU for address 192.168.11.2: 1472 [TRACE] [MPMD::MB_IFACE] Link type udp successful. [DEBUG] [MPMD] Found 16 motherboard sensors. [TRACE] [MPMD] Adding motherboard sensor `ref_locked' [TRACE] [MPMD] Adding motherboard sensor `fan0' [TRACE] [MPMD] Adding motherboard sensor `fan1' [TRACE] [MPMD] Adding motherboard sensor `temp_fpga' [TRACE] [MPMD] Adding motherboard sensor `temp_main_power' [TRACE] [MPMD] Adding motherboard sensor `temp_scu_internal' [TRACE] [MPMD] Adding motherboard sensor `gps_alarm' [TRACE] [MPMD] Adding motherboard sensor `gps_enabled' [TRACE] [MPMD] Adding motherboard sensor `gps_gpgga' [TRACE] [MPMD] Adding motherboard sensor `gps_locked' [TRACE] [MPMD] Adding motherboard sensor `gps_phase_lock' [TRACE] [MPMD] Adding motherboard sensor `gps_sky' [TRACE] [MPMD] Adding motherboard sensor `gps_survey' [TRACE] [MPMD] Adding motherboard sensor `gps_time' [TRACE] [MPMD] Adding motherboard sensor `gps_tpv' [TRACE] [MPMD] Adding motherboard sensor `gps_warmup' [DEBUG] [MPMD] Found 2 updateable motherboard components. [TRACE] [MPMD] Adding motherboard component: fpga [TRACE] [MPMD] Adding motherboard component: dts [TRACE] [RFNOC::GRAPH] Initializing MB controllers... [TRACE] [RFNOC::GRAPH] Initializing GSM... [TRACE] [RFNOC::GRAPH] Creating packet factory with CHDR width 64 bits and endianness LITTLE [TRACE] [RFNOC::GRAPH] Found a total of 1 links. [TRACE] [UDP] Created UDP link to 192.168.11.2:49153 [TRACE] [UDP] Local UDP socket endpoint: 192.168.11.1:53114 [TRACE] [UDP] Target/actual recv sock buff size: 25000000/25000000 bytes [TRACE] [UDP] Target/actual send sock buff size: 25000000/25000000 bytes [DEBUG] [RFNOC::MGMT] Starting topology discovery from device[local]:2/sep:1 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device[local]:2/sep:1, output port -1 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:1} [DEBUG] [RFNOC::MGMT] Discovered node device:1/xport:1 [DEBUG] [RFNOC::MGMT] Initialized node device:1/xport:1 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xport:1, output port -1 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:2} [DEBUG] [RFNOC::MGMT] Discovered node device:1/xbar:0 [DEBUG] [RFNOC::MGMT] Initialized node device:1/xbar:0 [TRACE] [RFNOC::MGMT] * device:1/xbar:0 has 15 ports, 6 transports and we are hooked up on port 1 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 0 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [TRACE] [RFNOC::MGMT] Nothing connected on device:1/xbar:0->0. Ignoring that path. [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 2 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [TRACE] [RFNOC::MGMT] Nothing connected on device:1/xbar:0->2. Ignoring that path. [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 3 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [TRACE] [RFNOC::MGMT] Nothing connected on device:1/xbar:0->3. Ignoring that path. [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 4 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [TRACE] [RFNOC::MGMT] Nothing connected on device:1/xbar:0->4. Ignoring that path. [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 5 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [TRACE] [RFNOC::MGMT] Nothing connected on device:1/xbar:0->5. Ignoring that path. [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 6 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:0 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:0 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 7 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:1 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:1 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 8 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:2 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:2 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 9 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:3 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:3 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 10 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:4 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:4 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 11 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:5 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:5 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 12 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:6 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:6 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 13 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:7 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:7 [TRACE] [RFNOC::MGMT] Discovering next node upstream from device:1/xbar:0, output port 14 using management transaction: mgmt_payload{src_epid:1, chdr_w:0, protover:0x100, num_hops:3} [DEBUG] [RFNOC::MGMT] Discovered node device:1/sep:8 [DEBUG] [RFNOC::MGMT] Initialized node device:1/sep:8 [DEBUG] [RFNOC::MGMT] The following endpoints are reachable from device[local]:2/sep:1 [DEBUG] [RFNOC::MGMT] * 1:0 [DEBUG] [RFNOC::MGMT] * 1:1 [DEBUG] [RFNOC::MGMT] * 1:2 [DEBUG] [RFNOC::MGMT] * 1:3 [DEBUG] [RFNOC::MGMT] * 1:4 [DEBUG] [RFNOC::MGMT] * 1:5 [DEBUG] [RFNOC::MGMT] * 1:6 [DEBUG] [RFNOC::MGMT] * 1:7 [DEBUG] [RFNOC::MGMT] * 1:8 [TRACE] [RFNOC::GRAPH] RFNoC Topology: digraph rfnoc_topo_graph { rankdir=TB; node [colorscheme=paired12]; 0 [label="device[local]:2/sep:1",shape=house,color=2]; 1 [label="device:1/xport:1",shape=diamond,color=1]; 2 [label="device:1/xbar:0",shape=hexagon,color=1]; 3 [label="device:1/sep:0",shape=house,color=1]; 4 [label="device:1/sep:1",shape=house,color=1]; 5 [label="device:1/sep:2",shape=house,color=1]; 6 [label="device:1/sep:3",shape=house,color=1]; 7 [label="device:1/sep:4",shape=house,color=1]; 8 [label="device:1/sep:5",shape=house,color=1]; 9 [label="device:1/sep:6",shape=house,color=1]; 10 [label="device:1/sep:7",shape=house,color=1]; 11 [label="device:1/sep:8",shape=house,color=1]; 0 -> 1 [xlabel="1"]; 1 -> 0 [xlabel="1"]; 1 -> 2 [xlabel="1"]; 2 -> 1 [xlabel="1"]; 2 -> 3 [xlabel="1"]; 3 -> 2 [xlabel="1"]; 2 -> 4 [xlabel="1"]; 4 -> 2 [xlabel="1"]; 2 -> 5 [xlabel="1"]; 5 -> 2 [xlabel="1"]; 2 -> 6 [xlabel="1"]; 6 -> 2 [xlabel="1"]; 2 -> 7 [xlabel="1"]; 7 -> 2 [xlabel="1"]; 2 -> 8 [xlabel="1"]; 8 -> 2 [xlabel="1"]; 2 -> 9 [xlabel="1"]; 9 -> 2 [xlabel="1"]; 2 -> 10 [xlabel="1"]; 10 -> 2 [xlabel="1"]; 2 -> 11 [xlabel="1"]; 11 -> 2 [xlabel="1"]; } [TRACE] [RFNOC::GRAPH] Initializing blocks for MB 0... [DEBUG] [RFNOC::GRAPH] Connecting the Host to Endpoint 1:0 through Adapter 0 (0 = no preference)... [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Bound stream endpoint with Addr=(1,0) to EPID=2 [TRACE] [RFNOC::MGMT] Stream endpoint with EPID=2 can be reached by taking the path: device[local]:2/sep:1,-1-H->device:1/xport:1,-1->device:1/xbar:0,6->device:1/sep:0, [DEBUG] [RFNOC] Started thread uhd_ctrl_ep0001 to process messages control messages on EPID 1 [TRACE] [RFNOC::MGMT] Setting up local route: device[local]:2/sep:1,-1-H->device:1/xport:1,-1->device:1/xbar:0,6->device:1/sep:0, [TRACE] [RFNOC::MGMT] Initializing node device[local]:2/sep:1 to send data back to EPID 1 [TRACE] [RFNOC::MGMT] Initializing node device:1/xport:1 to send data back to EPID 1 [TRACE] [RFNOC::MGMT] Initializing node device:1/xbar:0 to send data back to EPID 1 [DEBUG] [RFNOC::MGMT] Established a route from EPID=1 (SW) to EPID=2 [TRACE] [RFNOC::MGMT] The destination for EPID=2 has been added to all routers in the path: device[local]:2/sep:1,-1-H->device:1/xport:1,-1->device:1/xbar:0,6-> [DEBUG] [RFNOC] Created ctrlport endpoint for port 0 on EPID 1 [DEBUG] [RFNOC::GRAPH] Connection to Endpoint 1:0 completed through Device 2. Using EPIDs 1 -> 2. [TRACE] [RFNOC::GRAPH] Flushing and resetting blocks on mboard 0 [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID 'bus_clk' [DEBUG] [RFNOC] Created ctrlport endpoint for port 2 on EPID 1 [TRACE] [0/DUC#0] Using timebase clock: `__graph__'. Current frequency: 0 MHz [TRACE] [0/DUC#0] Using ctrlport clock: `bus_clk'. Current frequency: 200 MHz [DEBUG] [0/DUC#0] Checking compat number for FPGA component `0/DUC#0': Expecting 0.1, actual: 0.1. [DEBUG] [0/DUC#0] Loading DUC with 3 halfbands and max CIC interpolation 255 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/DUC#0 (NOC ID=d0c00000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID 'bus_clk' [DEBUG] [RFNOC] Created ctrlport endpoint for port 3 on EPID 1 [TRACE] [0/DDC#0] Using timebase clock: `__graph__'. Current frequency: 0 MHz [TRACE] [0/DDC#0] Using ctrlport clock: `bus_clk'. Current frequency: 200 MHz [DEBUG] [0/DDC#0] Checking compat number for FPGA component `0/DDC#0': Expecting 0.1, actual: 0.1. [DEBUG] [0/DDC#0] Loading DDC with 3 halfbands and max CIC decimation 255 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/DDC#0 (NOC ID=ddc00000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID '1' [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID '4' [DEBUG] [RFNOC] Created ctrlport endpoint for port 4 on EPID 1 [TRACE] [0/Radio#0] Using timebase clock: `4'. Current frequency: 245.76 MHz [TRACE] [0/Radio#0] Using ctrlport clock: `1'. Current frequency: 40 MHz [DEBUG] [0/Radio#0] Checking compat number for FPGA component `0/Radio#0': Expecting 0.1, actual: 0.1. [TRACE] [0/Radio#0] Loading radio with SPC=2, num_inputs=2, num_outputs=2 [TRACE] [0/Radio#0] Sending async messages to EPID 1, remote port 4, xbar port 1 [TRACE] [0/Radio#0] Initializing x400_radio_control [TRACE] [0/Radio#0] num timekeepers: 1radio slot: A [TRACE] [0/Radio#0] Hardware detected 2 daughterboards. [TRACE] [0/Radio#0] Setting property samp_rate@INPUT_EDGE:0 [TRACE] [0/Radio#0] Locally resolving 23 dirty properties plus dependencies. [TRACE] [0/Radio#0] Calling resolver for spp@0 [TRACE] [0/Radio#0] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#0] Calling resolver for spp@1 [TRACE] [0/Radio#0] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#0] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size out@0 [TRACE] [0/Radio#0] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#0] Calling resolver for spp@0 [TRACE] [0/Radio#0] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#0] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size out@1 [TRACE] [0/Radio#0] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#0] Calling resolver for spp@1 [TRACE] [0/Radio#0] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#0] Calling resolver for atomic_item_size out@0 [TRACE] [0/Radio#0] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#0] Calling resolver for spp@0 [TRACE] [0/Radio#0] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#0] Calling resolver for samp_rate@0 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size out@1 [TRACE] [0/Radio#0] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#0] Calling resolver for spp@1 [TRACE] [0/Radio#0] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#0] Calling resolver for samp_rate@1 [TRACE] [0/Radio#0] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size in@0 [TRACE] [0/Radio#0] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#0] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size in@1 [TRACE] [0/Radio#0] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size in@0 [TRACE] [0/Radio#0] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#0] Calling resolver for samp_rate@0 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size in@1 [TRACE] [0/Radio#0] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#0] Calling resolver for samp_rate@1 [TRACE] [0/Radio#0] Setting words_per_pkt to 1016 on chan 0 [TRACE] [0/Radio#0] Setting words_per_pkt to 1016 on chan 1 [TRACE] [0/Radio#0] Setting property samp_rate@INPUT_EDGE:1 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [0/Radio#0] Setting property samp_rate@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [0/Radio#0] Setting property samp_rate@OUTPUT_EDGE:1 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [DEBUG] [0/Radio#0] Master Clock Rate is: 245.76 MHz. [TRACE] [0/Radio#0] Chan 0: Found 2 rx sensors. [TRACE] [0/Radio#0] Adding rx sensor temperature [TRACE] [0/Radio#0] Adding rx sensor rfdc_rate [TRACE] [0/Radio#0] Chan 1: Found 2 rx sensors. [TRACE] [0/Radio#0] Adding rx sensor temperature [TRACE] [0/Radio#0] Adding rx sensor rfdc_rate [TRACE] [0/Radio#0] Chan 0: Found 2 tx sensors. [TRACE] [0/Radio#0] Adding tx sensor temperature [TRACE] [0/Radio#0] Adding tx sensor rfdc_rate [TRACE] [0/Radio#0] Chan 1: Found 2 tx sensors. [TRACE] [0/Radio#0] Adding tx sensor temperature [TRACE] [0/Radio#0] Adding tx sensor rfdc_rate [TRACE] [0/Radio#0] Initializing RFDC controls... [TRACE] [0/Radio#0] Initializing daughterboard driver for PID 16386 [TRACE] [0/Radio#0] Entering zbx_dboard_impl ctor... [TRACE] [0/Radio#0] Radio slot: A [TRACE] [0/Radio#0] Initializing CPLD... [TRACE] [0/Radio#0::CPLD] Entering CPLD ctor... [TRACE] [0/Radio#0::CPLD] Storing register cache completely to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 4357 registers. [TRACE] [0/Radio#0] Testing CPLD communication... [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0] CPLD communication good. Switching to classic ATR mode. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0] Initializing peripherals... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_tx_32868DE.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_tx.cal [TRACE] [0/Radio#0] load binary TX DSA steps from database... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_tx_32868DE.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_tx.cal [TRACE] [0/Radio#0] create TX DSA object... [TRACE] [0/Radio#0] store deserialized TX DSA data into object... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_rx_32868DE.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_rx.cal [TRACE] [0/Radio#0] load binary RX DSA steps from database... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_rx_32868DE.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_rx.cal [TRACE] [0/Radio#0] create RX DSA object... [TRACE] [0/Radio#0] store deserialized RX DSA data into object... [TRACE] [0/Radio#0] Adding non-RFNoC block properties for channel 0 to prop tree path rx_frontends/0 [TRACE] [0/Radio#0] rx_frontends/0, Creating experts... [TRACE] [ZBX RX0 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX0 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX0 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX RX0 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX0 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX0 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#0] LO step size: 10.24 MHz. [TRACE] [0/Radio#0] rx_frontends/0, Experts created [TRACE] [0/Radio#0] Adding non-RFNoC block properties for channel 1 to prop tree path rx_frontends/1 [TRACE] [0/Radio#0] rx_frontends/1, Creating experts... [TRACE] [ZBX RX1 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX1 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX1 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX RX1 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX1 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX1 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#0] LO step size: 10.24 MHz. [TRACE] [0/Radio#0] rx_frontends/1, Experts created [TRACE] [0/Radio#0] Adding non-RFNoC block properties for channel 0 to prop tree path tx_frontends/0 [TRACE] [0/Radio#0] tx_frontends/0, Creating experts... [TRACE] [ZBX TX0 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX0 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX0 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX TX0 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX0 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX0 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#0] LO step size: 10.24 MHz. [TRACE] [0/Radio#0] tx_frontends/0, Experts created [TRACE] [0/Radio#0] Adding non-RFNoC block properties for channel 1 to prop tree path tx_frontends/1 [TRACE] [0/Radio#0] tx_frontends/1, Creating experts... [TRACE] [ZBX TX1 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX1 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX1 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX TX1 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX1 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX1 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#0] LO step size: 10.24 MHz. [TRACE] [0/Radio#0] tx_frontends/1, Experts created [TRACE] [ZBX TX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO2] Setting LO frequency 3553.28 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=3553.28 MHz, fOSC=61.44 MHz: Target fVCO=3553.28 MHz, actual fVCO=3553.28 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=57 PLL_DEN=61440000 PLL_NUM=51200000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 7 registers. [TRACE] [ZBX TX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO1] Setting LO frequency 5611.52 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=5611.52 MHz, fOSC=61.44 MHz: Target fVCO=5611.52 MHz, actual fVCO=5611.52 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=91 PLL_DEN=61440000 PLL_NUM=20480000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 9 registers. [TRACE] [ZBX TX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO2] Setting LO frequency 3532.8 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=3532.8 MHz, fOSC=61.44 MHz: Target fVCO=3532.8 MHz, actual fVCO=3532.8 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=57 PLL_DEN=61440000 PLL_NUM=30720000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 7 registers. [TRACE] [ZBX TX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO1] Setting LO frequency 5591.04 MHz [TRACE] [LMX2572] Sync Category: 1A [TRACE] [LMX2572] Calculating settings for fTARGET=5591.04 MHz, fOSC=61.44 MHz: Target fVCO=5591.04 MHz, actual fVCO=5591.04 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=91 PLL_DEN=61440000 PLL_NUM=0 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 11 registers. [TRACE] [ZBX RX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO2] Setting LO frequency 6256.64 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=6256.64 MHz, fOSC=61.44 MHz: Target fVCO=6256.64 MHz, actual fVCO=6256.64 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=101 PLL_DEN=61440000 PLL_NUM=51200000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 8 registers. [TRACE] [ZBX RX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO1] Setting LO frequency 5109.76 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=5109.76 MHz, fOSC=61.44 MHz: Target fVCO=5109.76 MHz, actual fVCO=5109.76 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=83 PLL_DEN=61440000 PLL_NUM=10240000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 9 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Set TX DSA for channel 1: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Set TX DSA for channel 1: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX0_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX0_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX1_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX1_TABLE_DSA2 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 122 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Setting RX DSA for channel 1: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Setting RX DSA for channel 1: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA3_A [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA3_B [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA3_A [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA3_B [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 120 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [ZBX RX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO2] Setting LO frequency 6236.16 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=6236.16 MHz, fOSC=61.44 MHz: Target fVCO=6236.16 MHz, actual fVCO=6236.16 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=101 PLL_DEN=61440000 PLL_NUM=30720000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 8 registers. [TRACE] [ZBX RX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO1] Setting LO frequency 5089.28 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=5089.28 MHz, fOSC=61.44 MHz: Target fVCO=5089.28 MHz, actual fVCO=5089.28 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=82 PLL_DEN=61440000 PLL_NUM=51200000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 9 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Set TX DSA for channel 0: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Set TX DSA for channel 0: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX0_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX0_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX1_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register TX1_TABLE_DSA2 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Setting RX DSA for channel 0: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Setting RX DSA for channel 0: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA3_A [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA3_B [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA3_A [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA3_B [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [zbx_sync_expert] No command time: Skipping phase sync. [TRACE] [0/Radio#0] Adding non-RFNoC block properties for channel 0 to prop tree paths rx_codec/0 and tx_codec/0 [TRACE] [0/Radio#0] Adding non-RFNoC block properties for channel 1 to prop tree paths rx_codec/1 and tx_codec/1 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/Radio#0 (NOC ID=12ad1000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID 'bus_clk' [DEBUG] [RFNOC] Created ctrlport endpoint for port 5 on EPID 1 [TRACE] [0/DUC#1] Using timebase clock: `__graph__'. Current frequency: 0 MHz [TRACE] [0/DUC#1] Using ctrlport clock: `bus_clk'. Current frequency: 200 MHz [DEBUG] [0/DUC#1] Checking compat number for FPGA component `0/DUC#1': Expecting 0.1, actual: 0.1. [DEBUG] [0/DUC#1] Loading DUC with 3 halfbands and max CIC interpolation 255 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/DUC#1 (NOC ID=d0c00000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID 'bus_clk' [DEBUG] [RFNOC] Created ctrlport endpoint for port 6 on EPID 1 [TRACE] [0/DDC#1] Using timebase clock: `__graph__'. Current frequency: 0 MHz [TRACE] [0/DDC#1] Using ctrlport clock: `bus_clk'. Current frequency: 200 MHz [DEBUG] [0/DDC#1] Checking compat number for FPGA component `0/DDC#1': Expecting 0.1, actual: 0.1. [DEBUG] [0/DDC#1] Loading DDC with 3 halfbands and max CIC decimation 255 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/DDC#1 (NOC ID=ddc00000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID '1' [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID '4' [DEBUG] [RFNOC] Created ctrlport endpoint for port 7 on EPID 1 [TRACE] [0/Radio#1] Using timebase clock: `4'. Current frequency: 245.76 MHz [TRACE] [0/Radio#1] Using ctrlport clock: `1'. Current frequency: 40 MHz [DEBUG] [0/Radio#1] Checking compat number for FPGA component `0/Radio#1': Expecting 0.1, actual: 0.1. [TRACE] [0/Radio#1] Loading radio with SPC=2, num_inputs=2, num_outputs=2 [TRACE] [0/Radio#1] Sending async messages to EPID 1, remote port 7, xbar port 1 [TRACE] [0/Radio#1] Initializing x400_radio_control [TRACE] [0/Radio#1] num timekeepers: 1radio slot: B [TRACE] [0/Radio#1] Hardware detected 2 daughterboards. [TRACE] [0/Radio#1] Setting property samp_rate@INPUT_EDGE:0 [TRACE] [0/Radio#1] Locally resolving 23 dirty properties plus dependencies. [TRACE] [0/Radio#1] Calling resolver for spp@0 [TRACE] [0/Radio#1] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#1] Calling resolver for spp@1 [TRACE] [0/Radio#1] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#1] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size out@0 [TRACE] [0/Radio#1] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#1] Calling resolver for spp@0 [TRACE] [0/Radio#1] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#1] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size out@1 [TRACE] [0/Radio#1] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#1] Calling resolver for spp@1 [TRACE] [0/Radio#1] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#1] Calling resolver for atomic_item_size out@0 [TRACE] [0/Radio#1] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#1] Calling resolver for spp@0 [TRACE] [0/Radio#1] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#1] Calling resolver for samp_rate@0 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size out@1 [TRACE] [0/Radio#1] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#1] Calling resolver for spp@1 [TRACE] [0/Radio#1] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#1] Calling resolver for samp_rate@1 [TRACE] [0/Radio#1] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size in@0 [TRACE] [0/Radio#1] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#1] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size in@1 [TRACE] [0/Radio#1] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size in@0 [TRACE] [0/Radio#1] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#1] Calling resolver for samp_rate@0 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size in@1 [TRACE] [0/Radio#1] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#1] Calling resolver for samp_rate@1 [TRACE] [0/Radio#1] Setting words_per_pkt to 1016 on chan 0 [TRACE] [0/Radio#1] Setting words_per_pkt to 1016 on chan 1 [TRACE] [0/Radio#1] Setting property samp_rate@INPUT_EDGE:1 [TRACE] [0/Radio#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [0/Radio#1] Setting property samp_rate@OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [0/Radio#1] Setting property samp_rate@OUTPUT_EDGE:1 [TRACE] [0/Radio#1] Locally resolving 1 dirty properties plus dependencies. [DEBUG] [0/Radio#1] Master Clock Rate is: 245.76 MHz. [TRACE] [0/Radio#1] Chan 0: Found 2 rx sensors. [TRACE] [0/Radio#1] Adding rx sensor temperature [TRACE] [0/Radio#1] Adding rx sensor rfdc_rate [TRACE] [0/Radio#1] Chan 1: Found 2 rx sensors. [TRACE] [0/Radio#1] Adding rx sensor temperature [TRACE] [0/Radio#1] Adding rx sensor rfdc_rate [TRACE] [0/Radio#1] Chan 0: Found 2 tx sensors. [TRACE] [0/Radio#1] Adding tx sensor temperature [TRACE] [0/Radio#1] Adding tx sensor rfdc_rate [TRACE] [0/Radio#1] Chan 1: Found 2 tx sensors. [TRACE] [0/Radio#1] Adding tx sensor temperature [TRACE] [0/Radio#1] Adding tx sensor rfdc_rate [TRACE] [0/Radio#1] Initializing RFDC controls... [TRACE] [0/Radio#1] Initializing daughterboard driver for PID 16386 [TRACE] [0/Radio#1] Entering zbx_dboard_impl ctor... [TRACE] [0/Radio#1] Radio slot: B [TRACE] [0/Radio#1] Initializing CPLD... [TRACE] [0/Radio#1::CPLD] Entering CPLD ctor... [TRACE] [0/Radio#1::CPLD] Storing register cache completely to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 4357 registers. [TRACE] [0/Radio#1] Testing CPLD communication... [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1] CPLD communication good. Switching to classic ATR mode. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1] Initializing peripherals... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_tx_3278173.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_tx.cal [TRACE] [0/Radio#1] load binary TX DSA steps from database... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_tx_3278173.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_tx.cal [TRACE] [0/Radio#1] create TX DSA object... [TRACE] [0/Radio#1] store deserialized TX DSA data into object... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_rx_3278173.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_rx.cal [TRACE] [0/Radio#1] load binary RX DSA steps from database... [TRACE] [CAL::DATABASE] Checking for file at /home/user/.local/share/uhd/cal/zbx_dsa_rx_3278173.cal [TRACE] [CAL::DATABASE] Checking for resource cal/zbx_dsa_rx.cal [TRACE] [0/Radio#1] create RX DSA object... [TRACE] [0/Radio#1] store deserialized RX DSA data into object... [TRACE] [0/Radio#1] Adding non-RFNoC block properties for channel 0 to prop tree path rx_frontends/0 [TRACE] [0/Radio#1] rx_frontends/0, Creating experts... [TRACE] [ZBX RX0 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX0 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX0 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX RX0 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX0 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX0 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#1] LO step size: 10.24 MHz. [TRACE] [0/Radio#1] rx_frontends/0, Experts created [TRACE] [0/Radio#1] Adding non-RFNoC block properties for channel 1 to prop tree path rx_frontends/1 [TRACE] [0/Radio#1] rx_frontends/1, Creating experts... [TRACE] [ZBX RX1 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX1 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX1 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX RX1 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX RX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX RX1 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX RX1 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#1] LO step size: 10.24 MHz. [TRACE] [0/Radio#1] rx_frontends/1, Experts created [TRACE] [0/Radio#1] Adding non-RFNoC block properties for channel 0 to prop tree path tx_frontends/0 [TRACE] [0/Radio#1] tx_frontends/0, Creating experts... [TRACE] [ZBX TX0 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX0 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX0 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX TX0 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX0 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX0 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#1] LO step size: 10.24 MHz. [TRACE] [0/Radio#1] tx_frontends/0, Experts created [TRACE] [0/Radio#1] Adding non-RFNoC block properties for channel 1 to prop tree path tx_frontends/1 [TRACE] [0/Radio#1] tx_frontends/1, Creating experts... [TRACE] [ZBX TX1 LO1] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX1 LO1] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX1 LO1] Waiting for LO lock, 20 ms [TRACE] [ZBX TX1 LO2] LO initialized... [TRACE] [LMX2572] Communication with LMX2572 successful. [TRACE] [ZBX TX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 2 registers. [TRACE] [ZBX TX1 LO2] Setting LO frequency 4000 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=4000 MHz, fOSC=61.44 MHz: Target fVCO=4000 MHz, actual fVCO=4000 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=65 PLL_DEN=61440000 PLL_NUM=6400000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 12 registers. [TRACE] [ZBX TX1 LO2] Waiting for LO lock, 20 ms [DEBUG] [0/Radio#1] LO step size: 10.24 MHz. [TRACE] [0/Radio#1] tx_frontends/1, Experts created [TRACE] [ZBX TX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO2] Setting LO frequency 3553.28 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=3553.28 MHz, fOSC=61.44 MHz: Target fVCO=3553.28 MHz, actual fVCO=3553.28 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=57 PLL_DEN=61440000 PLL_NUM=51200000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 7 registers. [TRACE] [ZBX TX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX1 LO1] Setting LO frequency 5611.52 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=5611.52 MHz, fOSC=61.44 MHz: Target fVCO=5611.52 MHz, actual fVCO=5611.52 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=91 PLL_DEN=61440000 PLL_NUM=20480000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 9 registers. [TRACE] [ZBX TX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO2] Setting LO frequency 3532.8 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=3532.8 MHz, fOSC=61.44 MHz: Target fVCO=3532.8 MHz, actual fVCO=3532.8 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=57 PLL_DEN=61440000 PLL_NUM=30720000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 7 registers. [TRACE] [ZBX TX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX TX0 LO1] Setting LO frequency 5591.04 MHz [TRACE] [LMX2572] Sync Category: 1A [TRACE] [LMX2572] Calculating settings for fTARGET=5591.04 MHz, fOSC=61.44 MHz: Target fVCO=5591.04 MHz, actual fVCO=5591.04 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=91 PLL_DEN=61440000 PLL_NUM=0 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 11 registers. [TRACE] [ZBX RX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO2] Setting LO frequency 6256.64 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=6256.64 MHz, fOSC=61.44 MHz: Target fVCO=6256.64 MHz, actual fVCO=6256.64 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=101 PLL_DEN=61440000 PLL_NUM=51200000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 8 registers. [TRACE] [ZBX RX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX1 LO1] Setting LO frequency 5109.76 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=5109.76 MHz, fOSC=61.44 MHz: Target fVCO=5109.76 MHz, actual fVCO=5109.76 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=83 PLL_DEN=61440000 PLL_NUM=10240000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 9 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Set TX DSA for channel 1: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Set TX DSA for channel 1: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX0_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX0_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX1_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX1_TABLE_DSA2 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 122 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Setting RX DSA for channel 1: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Setting RX DSA for channel 1: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA3_A [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA3_B [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA3_A [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA3_B [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 120 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [ZBX RX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO2] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO2] Setting LO frequency 6236.16 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=6236.16 MHz, fOSC=61.44 MHz: Target fVCO=6236.16 MHz, actual fVCO=6236.16 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=101 PLL_DEN=61440000 PLL_NUM=30720000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 8 registers. [TRACE] [ZBX RX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO1] Enabling LO output port [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 0 registers. [TRACE] [ZBX RX0 LO1] Setting LO frequency 5089.28 MHz [TRACE] [LMX2572] Sync Category: 3 [TRACE] [LMX2572] Calculating settings for fTARGET=5089.28 MHz, fOSC=61.44 MHz: Target fVCO=5089.28 MHz, actual fVCO=5089.28 MHz. R_pre=1 OSC2X=0 MULT=1 PLL_R=1 P=1 N=82 PLL_DEN=61440000 PLL_NUM=51200000 CHDIV=1 [TRACE] [LMX2572] Storing register cache to LMX2572... [TRACE] [LMX2572] Storing cache complete: Updated 9 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Set TX DSA for channel 0: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Set TX DSA for channel 0: DSA1=29, DSA2=31, AMP=0 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX0_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX0_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX1_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX1_TABLE_DSA2 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Setting RX DSA for channel 0: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Setting RX DSA for channel 0: DSA1=15, DSA2=15, DSA3A=15, DSA3B=15 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA3_A [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX0_TABLE_DSA3_B [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA3_A [DEBUG] [0/Radio#1::CPLD] Write 61 values to register RX1_TABLE_DSA3_B [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [zbx_sync_expert] No command time: Skipping phase sync. [TRACE] [0/Radio#1] Adding non-RFNoC block properties for channel 0 to prop tree paths rx_codec/0 and tx_codec/0 [TRACE] [0/Radio#1] Adding non-RFNoC block properties for channel 1 to prop tree paths rx_codec/1 and tx_codec/1 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/Radio#1 (NOC ID=12ad1000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID 'bus_clk' [DEBUG] [RFNOC] Created ctrlport endpoint for port 8 on EPID 1 [TRACE] [0/Replay#0] Using timebase clock: `__graph__'. Current frequency: 0 MHz [TRACE] [0/Replay#0] Using ctrlport clock: `bus_clk'. Current frequency: 200 MHz [DEBUG] [0/Replay#0] Checking compat number for FPGA component `0/Replay#0': Expecting 1.2, actual: 1.2. [TRACE] [0/Replay#0] Initializing replay block with num ports=4 [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/Replay#0 (NOC ID=4e91a000) [TRACE] [MPMD::MB_IFACE] Looking up clock info for clock ID 'bus_clk' [DEBUG] [RFNOC] Created ctrlport endpoint for port 9 on EPID 1 [TRACE] [0/Gain#0] Using timebase clock: `__graph__'. Current frequency: 0 MHz [TRACE] [0/Gain#0] Using ctrlport clock: `bus_clk'. Current frequency: 200 MHz [DEBUG] [RFNOC::BLOCK_CONTAINER] Registering block: 0/Gain#0 (NOC ID=00000b16) [INFO] [0/Gain#0] Setting default MTU forward policy. [TRACE] [RFNOC::GRAPH] Initializing properties on all blocks... [TRACE] [0/Gain#0] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/Gain#0] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding new MTU value to edge OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding new MTU value to edge INPUT_EDGE:0 [TRACE] [0/Radio#1] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/Radio#1] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/Radio#1] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/Radio#1] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size in@0 [TRACE] [0/Radio#1] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size out@0 [TRACE] [0/Radio#1] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#1] Calling resolver for spp@0 [TRACE] [0/Radio#1] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#1] Calling resolver for samp_rate@0 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size in@1 [TRACE] [0/Radio#1] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#1] Calling resolver for atomic_item_size out@1 [TRACE] [0/Radio#1] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#1] Calling resolver for spp@1 [TRACE] [0/Radio#1] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#1] Calling resolver for samp_rate@1 [TRACE] [0/DDC#1] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/DDC#1] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/DDC#1] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/DDC#1] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/DDC#1] Forwarding new MTU value to edge OUTPUT_EDGE:0 [TRACE] [0/DDC#1] Forwarding new MTU value to edge OUTPUT_EDGE:1 [TRACE] [0/DDC#1] Forwarding new MTU value to edge INPUT_EDGE:0 [TRACE] [0/DDC#1] Forwarding new MTU value to edge INPUT_EDGE:1 [TRACE] [0/DDC#1] Calling resolver for `decim'@0 [TRACE] [0/DDC#1] Set decim to 1 [TRACE] [0/DDC#1] Calling resolver for `freq'@0 [DEBUG] [0/DDC#1] Not setting frequency until sampling rate is set. [TRACE] [0/DDC#1] Calling resolver for `samp_rate_in/scaling_in'@0 [TRACE] [0/DDC#1] Calling resolver for `samp_rate_out/scaling_out'@0 [TRACE] [0/DDC#1] Calling resolver for `decim'@1 [TRACE] [0/DDC#1] Set decim to 1 [TRACE] [0/DDC#1] Calling resolver for `freq'@1 [DEBUG] [0/DDC#1] Not setting frequency until sampling rate is set. [TRACE] [0/DDC#1] Calling resolver for `samp_rate_in/scaling_in'@1 [TRACE] [0/DDC#1] Calling resolver for `samp_rate_out/scaling_out'@1 [TRACE] [0/DUC#1] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/DUC#1] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/DUC#1] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/DUC#1] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/DUC#1] Forwarding new MTU value to edge OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding new MTU value to edge OUTPUT_EDGE:1 [TRACE] [0/DUC#1] Forwarding new MTU value to edge INPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding new MTU value to edge INPUT_EDGE:1 [TRACE] [0/DUC#1] Calling resolver for `interp'@0 [TRACE] [0/DUC#1] Set interp to 1 [TRACE] [0/DUC#1] Calling resolver for `freq'@0 [DEBUG] [0/DUC#1] Not setting frequency until sampling rate is set. [TRACE] [0/DUC#1] Calling resolver for `samp_rate_in'@0 [TRACE] [0/DUC#1] Calling resolver for `samp_rate_out'@0 [TRACE] [0/DUC#1] Calling resolver for `scaling_out'@0 [TRACE] [0/DUC#1] Calling resolver for `interp'@1 [TRACE] [0/DUC#1] Set interp to 1 [TRACE] [0/DUC#1] Calling resolver for `freq'@1 [DEBUG] [0/DUC#1] Not setting frequency until sampling rate is set. [TRACE] [0/DUC#1] Calling resolver for `samp_rate_in'@1 [TRACE] [0/DUC#1] Calling resolver for `samp_rate_out'@1 [TRACE] [0/DUC#1] Calling resolver for `scaling_out'@1 [TRACE] [0/DDC#0] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/DDC#0] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/DDC#0] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/DDC#0] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/DDC#0] Forwarding new MTU value to edge OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding new MTU value to edge OUTPUT_EDGE:1 [TRACE] [0/DDC#0] Forwarding new MTU value to edge INPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding new MTU value to edge INPUT_EDGE:1 [TRACE] [0/DDC#0] Calling resolver for `decim'@0 [TRACE] [0/DDC#0] Set decim to 1 [TRACE] [0/DDC#0] Calling resolver for `freq'@0 [DEBUG] [0/DDC#0] Not setting frequency until sampling rate is set. [TRACE] [0/DDC#0] Calling resolver for `samp_rate_in/scaling_in'@0 [TRACE] [0/DDC#0] Calling resolver for `samp_rate_out/scaling_out'@0 [TRACE] [0/DDC#0] Calling resolver for `decim'@1 [TRACE] [0/DDC#0] Set decim to 1 [TRACE] [0/DDC#0] Calling resolver for `freq'@1 [DEBUG] [0/DDC#0] Not setting frequency until sampling rate is set. [TRACE] [0/DDC#0] Calling resolver for `samp_rate_in/scaling_in'@1 [TRACE] [0/DDC#0] Calling resolver for `samp_rate_out/scaling_out'@1 [TRACE] [0/Replay#0] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/Replay#0] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/Replay#0] MTU is now 8192 on edge INPUT_EDGE:2 [TRACE] [0/Replay#0] MTU is now 8192 on edge INPUT_EDGE:3 [TRACE] [0/Replay#0] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/Replay#0] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/Replay#0] MTU is now 8192 on edge OUTPUT_EDGE:2 [TRACE] [0/Replay#0] MTU is now 8192 on edge OUTPUT_EDGE:3 [TRACE] [0/Replay#0] Resolve atomic item size in to 8 [TRACE] [0/Replay#0] Resolve atomic item size in to 8 [TRACE] [0/Replay#0] Resolve atomic item size in to 8 [TRACE] [0/Replay#0] Resolve atomic item size in to 8 [TRACE] [0/Replay#0] Resolve atomic item size out to 8 [TRACE] [0/Replay#0] Resolve atomic item size out to 8 [TRACE] [0/Replay#0] Resolve atomic item size out to 8 [TRACE] [0/Replay#0] Resolve atomic item size out to 8 [TRACE] [0/Radio#0] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/Radio#0] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/Radio#0] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/Radio#0] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size in@0 [TRACE] [0/Radio#0] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size out@0 [TRACE] [0/Radio#0] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#0] Calling resolver for spp@0 [TRACE] [0/Radio#0] Exiting resolver for spp@0 (new value: 2032) [TRACE] [0/Radio#0] Calling resolver for samp_rate@0 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size in@1 [TRACE] [0/Radio#0] Resolving_atomic_item size in to 8 [TRACE] [0/Radio#0] Calling resolver for atomic_item_size out@1 [TRACE] [0/Radio#0] Resolving atomic_item_size out to 8 [TRACE] [0/Radio#0] Calling resolver for spp@1 [TRACE] [0/Radio#0] Exiting resolver for spp@1 (new value: 2032) [TRACE] [0/Radio#0] Calling resolver for samp_rate@1 [TRACE] [0/DUC#0] MTU is now 8192 on edge INPUT_EDGE:0 [TRACE] [0/DUC#0] MTU is now 8192 on edge INPUT_EDGE:1 [TRACE] [0/DUC#0] MTU is now 8192 on edge OUTPUT_EDGE:0 [TRACE] [0/DUC#0] MTU is now 8192 on edge OUTPUT_EDGE:1 [TRACE] [0/DUC#0] Forwarding new MTU value to edge OUTPUT_EDGE:0 [TRACE] [0/DUC#0] Forwarding new MTU value to edge OUTPUT_EDGE:1 [TRACE] [0/DUC#0] Forwarding new MTU value to edge INPUT_EDGE:0 [TRACE] [0/DUC#0] Forwarding new MTU value to edge INPUT_EDGE:1 [TRACE] [0/DUC#0] Calling resolver for `interp'@0 [TRACE] [0/DUC#0] Set interp to 1 [TRACE] [0/DUC#0] Calling resolver for `freq'@0 [DEBUG] [0/DUC#0] Not setting frequency until sampling rate is set. [TRACE] [0/DUC#0] Calling resolver for `samp_rate_in'@0 [TRACE] [0/DUC#0] Calling resolver for `samp_rate_out'@0 [TRACE] [0/DUC#0] Calling resolver for `scaling_out'@0 [TRACE] [0/DUC#0] Calling resolver for `interp'@1 [TRACE] [0/DUC#0] Set interp to 1 [TRACE] [0/DUC#0] Calling resolver for `freq'@1 [DEBUG] [0/DUC#0] Not setting frequency until sampling rate is set. [TRACE] [0/DUC#0] Calling resolver for `samp_rate_in'@1 [TRACE] [0/DUC#0] Calling resolver for `samp_rate_out'@1 [TRACE] [0/DUC#0] Calling resolver for `scaling_out'@1 [TRACE] [RFNOC::GRAPH] Identifying static connections... [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#0:0==>0/DUC#0:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/DUC#0:0==>0/Radio#0:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/Radio#0:0==>0/DDC#0:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/DDC#0:0==>0/SEP#0:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#1:0==>0/DUC#0:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/DUC#0:1==>0/Radio#0:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/Radio#0:1==>0/DDC#0:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/DDC#0:1==>0/SEP#1:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#2:0==>0/DUC#1:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/DUC#1:0==>0/Radio#1:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/Radio#1:0==>0/DDC#1:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/DDC#1:0==>0/SEP#2:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#3:0==>0/DUC#1:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/DUC#1:1==>0/Radio#1:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/Radio#1:1==>0/DDC#1:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/DDC#1:1==>0/SEP#3:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#4:0==>0/Replay#0:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/Replay#0:0==>0/SEP#4:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#5:0==>0/Replay#0:1 [TRACE] [RFNOC::GRAPH] Static connection: 0/Replay#0:1==>0/SEP#5:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#6:0==>0/Replay#0:2 [TRACE] [RFNOC::GRAPH] Static connection: 0/Replay#0:2==>0/SEP#6:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#7:0==>0/Replay#0:3 [TRACE] [RFNOC::GRAPH] Static connection: 0/Replay#0:3==>0/SEP#7:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/SEP#8:0==>0/Gain#0:0 [TRACE] [RFNOC::GRAPH] Static connection: 0/Gain#0:0==>0/SEP#8:0 [TRACE] [RFNOC::GRAPH] Calling MBC init for motherboard 0 [DEBUG] [MB_CTRL] Synchronizing 1 timekeepers Using RX radio 0/Radio#0, channel 0 Using TX radio 0/Radio#1, channel 0 [TRACE] [GRAPH_UTILS] Looking for current block 0/Radio#0, port 0 [TRACE] [GRAPH_UTILS] --> Found next block: 0/DDC#0 [TRACE] [GRAPH_UTILS] --> Found next block: 0/SEP#0 [TRACE] [GRAPH_UTILS] Found source chain for 0/Radio#0 [TRACE] [GRAPH_UTILS] Looking for current block 0/Gain#0, port 0 [TRACE] [GRAPH_UTILS] --> Found next block: 0/Gain#0 [TRACE] [GRAPH_UTILS] Found destination chain for 0/Gain#0 [TRACE] [RFNOC::GRAPH] Blocks 0/Radio#0:0 and 0/DDC#0:0 are statically connected [TRACE] [RFNOC::GRAPH::DETAIL] Connecting block 0/Radio#0:0 -> 0/DDC#0:0 [DEBUG] [RFNOC::GRAPH] Initializing data stream from Endpoint 1:0 to Endpoint 1:8... [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Bound stream endpoint with Addr=(1,8) to EPID=3 [TRACE] [RFNOC::MGMT] Stream endpoint with EPID=3 can be reached by taking the path: device[local]:2/sep:1,-1-H->device:1/xport:1,-1->device:1/xbar:0,14->device:1/sep:8, [DEBUG] [RFNOC::MGMT] Programmed a route from EPID=2 to EPID=3 [DEBUG] [RFNOC::GRAPH] Connection from Endpoint 1:0 to Endpoint 1:8 completed through Device 2. Using EPIDs 2 -> 3. [DEBUG] [RFNOC::MGMT] Programmed a route from EPID=2 to EPID=3 [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Setup a stream from EPID=2 to EPID=3 [DEBUG] [RFNOC::MGMT] Programmed a route from EPID=2 to EPID=3 [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Setup a stream from EPID=2 to EPID=3 [DEBUG] [RFNOC::GRAPH] Data stream between EPID 2 and EPID 3 established where downstream buffer can hold 32767 bytes and 16777215 packets [TRACE] [RFNOC::GRAPH::DETAIL] Connecting block 0/DDC#0:0 -> 0/Gain#0:0 [TRACE] [GRAPH_UTILS] Looking for current block 0/Gain#0, port 0 [TRACE] [GRAPH_UTILS] --> Found next block: 0/SEP#8 [TRACE] [GRAPH_UTILS] Found source chain for 0/Gain#0 [TRACE] [GRAPH_UTILS] Looking for current block 0/Radio#1, port 0 [TRACE] [GRAPH_UTILS] --> Found next block: 0/Radio#1 [TRACE] [GRAPH_UTILS] Looking for current block 0/DUC#1, port 0 [TRACE] [GRAPH_UTILS] --> Found next block: 0/DUC#1 [TRACE] [GRAPH_UTILS] Found destination chain for 0/Radio#1 [TRACE] [RFNOC::GRAPH] Blocks 0/DUC#1:0 and 0/Radio#1:0 are statically connected [TRACE] [RFNOC::GRAPH::DETAIL] Connecting block 0/DUC#1:0 -> 0/Radio#1:0 [DEBUG] [RFNOC::GRAPH] Initializing data stream from Endpoint 1:8 to Endpoint 1:2... [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Bound stream endpoint with Addr=(1,2) to EPID=4 [TRACE] [RFNOC::MGMT] Stream endpoint with EPID=4 can be reached by taking the path: device[local]:2/sep:1,-1-H->device:1/xport:1,-1->device:1/xbar:0,8->device:1/sep:2, [DEBUG] [RFNOC::MGMT] Programmed a route from EPID=3 to EPID=4 [DEBUG] [RFNOC::GRAPH] Connection from Endpoint 1:8 to Endpoint 1:2 completed through Device 2. Using EPIDs 3 -> 4. [DEBUG] [RFNOC::MGMT] Programmed a route from EPID=3 to EPID=4 [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Setup a stream from EPID=3 to EPID=4 [DEBUG] [RFNOC::MGMT] Programmed a route from EPID=3 to EPID=4 [DEBUG] [RFNOC::MGMT] Throttling stream endpoint to 100% (0x0) [DEBUG] [RFNOC::MGMT] Setup a stream from EPID=3 to EPID=4 [DEBUG] [RFNOC::GRAPH] Data stream between EPID 3 and EPID 4 established where downstream buffer can hold 262143 bytes and 16777215 packets [TRACE] [RFNOC::GRAPH::DETAIL] Connecting block 0/Gain#0:0 -> 0/DUC#1:0 [TRACE] [RFNOC::GRAPH::DETAIL] Running forward edge property propagation... [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#0 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#0 along forward edges. [TRACE] [0/DDC#0] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Received unknown incoming edge prop: atomic_item_size [TRACE] [0/DDC#0] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DDC#0 [TRACE] [0/DDC#0] Locally resolving 5 dirty properties plus dependencies. [TRACE] [0/DDC#0] Updating tick rate to 245.76 MHz [TRACE] [0/DDC#0] Calling resolver for `samp_rate_in/scaling_in'@0 [TRACE] [0/DDC#0] New samp_rate_in is 2.4576e+08 [TRACE] [0/DDC#0] Calling resolver for `samp_rate_out/scaling_out'@0 [TRACE] [0/DDC#0] Set decim to 1 [TRACE] [0/DDC#0] Calling resolver for `freq'@0 [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DDC#0 along forward edges. [TRACE] [0/Gain#0] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Received unknown incoming edge prop: samp_rate [TRACE] [0/Gain#0] Incoming edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Skipped empty edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Received unknown incoming edge prop: type [TRACE] [0/Gain#0] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Received unknown incoming edge prop: atomic_item_size [TRACE] [0/Radio#0] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Skipped empty edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Gain#0 [TRACE] [0/Gain#0] Locally resolving 8 dirty properties plus dependencies. [TRACE] [0/Gain#0] Updating tick rate to 245.76 MHz [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 10 edge properties from node 0/Gain#0 along forward edges. [TRACE] [0/DUC#1] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Received unknown incoming edge prop: atomic_item_size [TRACE] [0/DDC#0] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DUC#1 [TRACE] [0/DUC#1] Locally resolving 5 dirty properties plus dependencies. [TRACE] [0/DUC#1] Updating tick rate to 245.76 MHz [TRACE] [0/DUC#1] Calling resolver for `samp_rate_in'@0 [TRACE] [0/DUC#1] New samp_rate_in is 2.4576e+08 [TRACE] [0/DUC#1] New samp_rate_out is 2.4576e+08 [TRACE] [0/DUC#1] Calling resolver for `samp_rate_out'@0 [TRACE] [0/DUC#1] Calling resolver for `freq'@0 [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DUC#1 along forward edges. [TRACE] [0/Radio#1] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Skipped empty edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Skipped empty edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#1 [TRACE] [0/Radio#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#1 along forward edges. [TRACE] [0/DUC#1] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DUC#1 [TRACE] [0/DUC#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DUC#1 along forward edges. [TRACE] [0/Radio#1] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Skipped empty edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#1] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Skipped empty edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Gain#0 [TRACE] [0/Gain#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 10 edge properties from node 0/Gain#0 along forward edges. [TRACE] [0/DUC#1] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DDC#0 [TRACE] [0/DDC#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DDC#0 along forward edges. [TRACE] [0/Gain#0] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Skipped empty edge property: `scaling`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `tick_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `mtu`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `samp_rate`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Skipped empty edge property: `scaling`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `type`, source info: INPUT_EDGE:0 [TRACE] [0/Radio#0] Incoming edge property: `atomic_item_size`, source info: INPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Terminating graph resolution after iteration 1 [TRACE] [RFNOC::GRAPH::DETAIL] Running backward edge property propagation... [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#0 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DDC#0 [TRACE] [0/DDC#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DDC#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Gain#0 [TRACE] [0/Gain#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 10 edge properties from node 0/Gain#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DUC#1 [TRACE] [0/DUC#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DUC#1 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#1 [TRACE] [0/Radio#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#1 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DUC#1 [TRACE] [0/DUC#1] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DUC#1 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Gain#0 [TRACE] [0/Gain#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 10 edge properties from node 0/Gain#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/DDC#0 [TRACE] [0/DDC#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 22 edge properties from node 0/DDC#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Terminating graph resolution after iteration 1 [TRACE] [RFNOC::GRAPH] new graph committed digraph rfnoc_graph { rankdir=LR node [shape=record] subgraph "cluster_0/DDC#0" { label="0/DDC#0" "0/DDC#0_in" [label="in| 0| 1"] "0/DDC#0_out" [label="out| 0| 1"] } "0/DDC#0_in" -> "0/DDC#0_out" [style=invis] subgraph "cluster_0/Radio#0" { label="0/Radio#0" "0/Radio#0_in" [label="in| 0| 1"] "0/Radio#0_out" [label="out| 0| 1"] } "0/Radio#0_in" -> "0/Radio#0_out" [style=invis] subgraph "cluster_0/DUC#1" { label="0/DUC#1" "0/DUC#1_in" [label="in| 0| 1"] "0/DUC#1_out" [label="out| 0| 1"] } "0/DUC#1_in" -> "0/DUC#1_out" [style=invis] subgraph "cluster_0/Radio#1" { label="0/Radio#1" "0/Radio#1_in" [label="in| 0| 1"] "0/Radio#1_out" [label="out| 0| 1"] } "0/Radio#1_in" -> "0/Radio#1_out" [style=invis] subgraph "cluster_0/Gain#0" { label="0/Gain#0" "0/Gain#0_in" [label="in| 0"] "0/Gain#0_out" [label="out| 0"] } "0/Gain#0_in" -> "0/Gain#0_out" [style=invis] "0/Radio#0_out":"out_0" -> "0/DDC#0_in":"in_0" [color="black:white:black",label="static",weight=10] "0/DDC#0_out":"out_0" -> "0/Gain#0_in":"in_0" [label="dynamic"] "0/DUC#1_out":"out_0" -> "0/Radio#1_in":"in_0" [color="black:white:black",label="static",weight=10] "0/Gain#0_out":"out_0" -> "0/DUC#1_in":"in_0" [label="dynamic"] } 0/Radio#0:0==>0/DDC#0:0 0/DDC#0:0-->0/Gain#0:0 0/DUC#1:0==>0/Radio#1:0 0/Gain#0:0-->0/DUC#1:0 Setting RX Rate: 256.000000 Msps... Actual RX Rate: 245.760000 Msps... [WARNING] [0/Radio#0] Requesting invalid sampling rate from device: 256 MHz. Actual rate is: 245.76 MHz. Setting RX Freq: 1000.000000 MHz... Actual RX Freq: 1000.000000 MHz... Setting TX Freq: 1000.000000 MHz... Actual TX Freq: 1000.000000 MHz... Setting RX Gain: 40.000000 dB... [TRACE] [0/Radio#0::CPLD] Setting RX DSA for channel 0: DSA1=0, DSA2=0, DSA3A=9, DSA3B=11 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#0::CPLD] Setting RX DSA for channel 0: DSA1=0, DSA2=0, DSA3A=9, DSA3B=11 [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 1 registers. [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA3_A [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX0_TABLE_DSA3_B [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA1 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA2 [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA3_A [DEBUG] [0/Radio#0::CPLD] Write 61 values to register RX1_TABLE_DSA3_B [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#0::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#0::CPLD] Storing cache complete: Updated 0 registers. Actual RX Gain: 40.000000 dB... Setting TX Gain: 40.000000 dB... [TRACE] [0/Radio#1::CPLD] Set TX DSA for channel 0: DSA1=9, DSA2=11, AMP=0 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [TRACE] [0/Radio#1::CPLD] Set TX DSA for channel 0: DSA1=9, DSA2=11, AMP=0 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 1 registers. [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX0_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX0_TABLE_DSA2 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX1_TABLE_DSA1 [DEBUG] [0/Radio#1::CPLD] Write 61 values to register TX1_TABLE_DSA2 [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. [TRACE] [0/Radio#1::CPLD] Storing register cache selectively to CPLD... [TRACE] [0/Radio#1::CPLD] Storing cache complete: Updated 0 registers. Actual TX Gain: 40.000000 dB... Setting samples per packet to: 112 [TRACE] [0/Radio#0] Setting property spp@USER:0 [TRACE] [RFNOC::GRAPH::DETAIL] Running forward edge property propagation... [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#0 [TRACE] [0/Radio#0] Locally resolving 2 dirty properties plus dependencies. [TRACE] [0/Radio#0] Calling resolver for spp@0 [TRACE] [0/Radio#0] Exiting resolver for spp@0 (new value: 112) [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#0 along forward edges. [TRACE] [0/DDC#0] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Setting words_per_pkt to 56 on chan 0 [TRACE] [RFNOC::GRAPH::DETAIL] Terminating graph resolution early during iteration 0 [TRACE] [RFNOC::GRAPH::DETAIL] Running backward edge property propagation... [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#0 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Terminating graph resolution early during iteration 0 [TRACE] [0/Radio#0] Getting property spp@USER:0 [TRACE] [RFNOC::GRAPH::DETAIL] Running forward edge property propagation... [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#0 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#0 along forward edges. [TRACE] [0/DDC#0] Incoming edge property: `tick_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `mtu`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `atomic_item_size`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `samp_rate`, source info: OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Incoming edge property: `type`, source info: OUTPUT_EDGE:0 [TRACE] [RFNOC::GRAPH::DETAIL] Terminating graph resolution early during iteration 0 [TRACE] [RFNOC::GRAPH::DETAIL] Running backward edge property propagation... [TRACE] [RFNOC::GRAPH::DETAIL] Now resolving next node: 0/Radio#0 Actual samples per packet = 112 [TRACE] [0/Radio#0] Locally resolving 1 dirty properties plus dependencies. [TRACE] [RFNOC::GRAPH::DETAIL] Forwarding up to 20 edge properties from node 0/Radio#0 along back edges. [TRACE] [RFNOC::GRAPH::DETAIL] Terminating graph resolution early during iteration 0 Issuing start stream cmd... [TRACE] [0/Radio#0] radio_control_impl::issue_stream_cmd(chan=0, mode=a) Wait... [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55023344l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#0 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#0 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#0 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#0 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#0 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#0 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#0 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55023468l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#1 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#1 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#1 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#1 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#1 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#1 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#1 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event U[TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55023630l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#2 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#2 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#2 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#2 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#2 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#2 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#2 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#0] Received async message to addr 0x00001000, data length 1 words, RX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#0] Async message timestamp: 55102938l O[TRACE] [0/Radio#0] Posting overrun event action message. [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action rx_event#3 to 0/DDC#0@INPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action rx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of rx_event#3 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action rx_event#3 to 0/Gain#0@INPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action rx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of rx_event#3 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action rx_event#3 to 0/DUC#1@INPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action rx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of rx_event#3 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action rx_event#3 to 0/Radio#1@INPUT_EDGE:0 [TRACE] [0/Radio#1] Dropping action rx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55023756l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#4 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#4 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#4 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#4 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#4 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#4 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#4 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55023880l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#5 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#5 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#5 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#5 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#5 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#5 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#5 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024042l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#6 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#6 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#6 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#6 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#6 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#6 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#6 to 0/Radio#0@OUTPUT_EDGE:0 U[TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024186l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#7 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#7 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#7 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#7 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#7 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#7 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#7 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024312l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#8 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#8 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#8 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#8 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#8 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#8 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#8 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024438l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#9 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#9 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#9 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#9 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#9 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#9 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#9 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event U[TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024582l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#10 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#10 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#10 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#10 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#10 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#10 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#10 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024726l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#11 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#11 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#11 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#11 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#11 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#11 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#11 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024850l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#12 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#12 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#12 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#12 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#12 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#12 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#12 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55024994l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#13 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#13 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#13 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#13 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#13 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#13 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#13 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025138l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#14 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#14 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#14 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#14 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#14 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#14 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#14 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025282l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#15 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#15 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#15 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#15 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#15 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#15 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#15 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025406l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#16 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#16 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#16 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#16 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#16 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#16 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#16 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025550l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#17 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#17 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#17 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#17 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#17 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#17 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#17 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025676l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#18 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#18 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#18 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#18 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#18 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#18 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#18 to 0/Radio#0@OUTPUT_EDGE:0 U[TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025820l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#19 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#19 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#19 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#19 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#19 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#19 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#19 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55025964l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#20 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#20 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#20 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#20 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#20 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#20 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#20 to 0/Radio#0@OUTPUT_EDGE:0 U[TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55026088l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#21 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#21 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#21 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#21 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#21 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#21 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#21 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55026252l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#22 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#22 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#22 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#22 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#22 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#22 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#22 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55026508l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#23 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#23 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#23 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#23 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#23 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#23 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#23 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event U[TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55026664l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#24 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#24 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#24 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#24 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#24 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#24 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#24 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event U[TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55026790l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#25 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#25 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#25 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#25 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#25 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#25 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#25 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55026914l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#26 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#26 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#26 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#26 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#26 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#26 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#26 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027076l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#27 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#27 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#27 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#27 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#27 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#27 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#27 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027202l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#28 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#28 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#28 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#28 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#28 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#28 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#28 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027326l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#29 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#29 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#29 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#29 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#29 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#29 U[TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#29 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027472l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#30 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#30 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#30 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#30 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#30 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#30 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#30 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027616l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#31 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#31 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#31 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#31 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#31 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#31 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#31 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. U[TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027740l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#32 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#32 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#32 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#32 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#32 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#32 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#32 to 0/Radio#0@OUTPUT_EDGE:0 U[TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55027884l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#33 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#33 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#33 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#33 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#33 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#33 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#33 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. U[TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55041654l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#34 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#34 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#34 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#34 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#34 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#34 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#34 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event U[TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. [TRACE] [0/Radio#1] Received async message to addr 0x00000000, data length 1 words, TX channel 0, addr_offset 0, has timestamp 1 [TRACE] [0/Radio#1] Async message timestamp: 55101252l [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#35 to 0/DUC#1@OUTPUT_EDGE:0 [TRACE] [0/DUC#1] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#35 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#35 to 0/Gain#0@OUTPUT_EDGE:0 [TRACE] [0/Gain#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#35 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#35 to 0/DDC#0@OUTPUT_EDGE:0 [TRACE] [0/DDC#0] Forwarding action tx_event to opposite port [TRACE] [RFNOC::GRAPH::DETAIL] Action handling ongoing, deferring delivery of tx_event#35 [TRACE] [RFNOC::GRAPH::DETAIL] Now delivering action tx_event#35 to 0/Radio#0@OUTPUT_EDGE:0 [TRACE] [0/Radio#0] Dropping action tx_event [TRACE] [RFNOC::GRAPH::DETAIL] Delivered all actions, terminating action handling. [TRACE] [0/Radio#1] Posting underrun event action message. UIssuing stop stream cmd... [TRACE] [0/Radio#0] radio_control_impl::issue_stream_cmd(chan=0, mode=o) Done [TRACE] [RFNOC::GRAPH] Shutting down detail::graph... [TRACE] [RFNOC::GRAPH::DETAIL] graph::shutdown() [TRACE] [RFNOC::GRAPH] Shutting down all blocks ... [TRACE] [0/Gain#0] Calling deinit() [TRACE] [0/Gain#0] deinit() called, but not implemented. [TRACE] [0/Gain#0] Invalidating register interface [TRACE] [0/Radio#1] Calling deinit() [TRACE] [0/Radio#1] Invalidating register interface [TRACE] [0/DDC#1] Calling deinit() [TRACE] [0/DDC#1] deinit() called, but not implemented. [TRACE] [0/DDC#1] Invalidating register interface [TRACE] [0/DUC#1] Calling deinit() [TRACE] [0/DUC#1] deinit() called, but not implemented. [TRACE] [0/DUC#1] Invalidating register interface [TRACE] [0/Replay#0] Calling deinit() [TRACE] [0/Replay#0] deinit() called, but not implemented. [TRACE] [0/Replay#0] Invalidating register interface [TRACE] [0/Radio#0] Calling deinit() [TRACE] [0/Radio#0] Invalidating register interface [TRACE] [0/DDC#0] Calling deinit() [TRACE] [0/DDC#0] deinit() called, but not implemented. [TRACE] [0/DDC#0] Invalidating register interface [TRACE] [0/DUC#0] Calling deinit() [TRACE] [0/DUC#0] deinit() called, but not implemented. [TRACE] [0/DUC#0] Invalidating register interface [TRACE] [0/Radio#1] zbx_dboard::dtor() [TRACE] [0/Radio#0] zbx_dboard::dtor()