25-08-19 16:06:55.311.316 IRS: START [F1] 25-08-19 16:06:55.312.457 IRS: CONFIGURATION: 25-08-19 16:06:55.312.479 IRS: MCSP mode on slave with 4 Computer 25-08-19 16:06:55.313.778 DIS: Available physical memory = 905.3 MB 25-08-19 16:06:55.325.633 IRS: Configuration: local hardware startup done 25-08-19 16:06:57.504.203 BSC: PerfCheck: Processor #0-#4: read/write 2440.6 MB/s: OK 25-08-19 16:06:57.504.359 BSC: PerfCheck: Store MemReadWrite[MB/s]: Cur 2440, Prev 2442, New 2442 25-08-19 16:06:57.520.772 NET: Channel created [(9100)-S] 25-08-19 16:06:58.838.588 NET: Connected with IRSTCR(192.168.211.185)[(9100)-S] on IRSREC1(192.168.211.187) 25-08-19 16:07:33.730.519 NET: IRSCMD_DIS_STARTUP received from IRSTCR(192.168.211.185)[(9100)-S] (data=1064 B) 25-08-19 16:07:33.900.229 --> DIS_STARTUP Model = P30A(0) uProcess = 2 bComponents = REC(1) uRecInst = 1 nREC = 2 tIrsIni = \\IRSTCR\IRSP30 tRawData = \\IRSAQP\IRSP30.DAT tTables = \\IRSTCR\IRSP30.TBL tVolumes = \\IRSTCR\IRSP30.VOL 25-08-19 16:07:33.907.285 IRS: SOFTWARE: 25-08-19 16:07:33.907.541 IRS: Wow64Process = NO 25-08-19 16:07:33.907.584 IRS: Main host IP = 0.0.0.0 25-08-19 16:07:33.907.590 IRS: SynchroTimeout = 180 s 25-08-19 16:07:33.907.630 IRS: StartupTimeout = 60 s 25-08-19 16:07:33.907.637 IRS: NetConnTimeout = 30 s 25-08-19 16:07:33.907.645 IRS: Log archiving = YES 25-08-19 16:07:33.907.699 IRS: Log history = up to 100 files 25-08-19 16:07:33.907.752 IRS: DISK_INFO sig = YES 25-08-19 16:07:33.907.758 IRS: NetCloseError = YES 25-08-19 16:07:33.907.762 IRS: Exceptions = IRS 25-08-19 16:07:33.916.075 DIS: Scanning for physical drives ... 25-08-19 16:07:34.221.033 DIS: Drive 0 SN:UPU0P5701V2V FW:0108 GD:0 INFO:Drive 0 SCSI [2:0:1:0][ 40/8 ] FUJITSU MAP3367NP 37GB DST 3 EXT 1539s ON ? h 25-08-19 16:07:34.221.073 DIS: Drive 1 SN:UPU0P5701V3N FW:0108 GD:0 INFO:Drive 1 SCSI [3:0:1:0][ 40/8 ] FUJITSU MAP3367NP 37GB DST 3 EXT 1539s ON ? h 25-08-19 16:07:34.221.221 NET: IRSCMD_DIS_LOG sent to IRSTCR(192.168.211.185)[(9100)-S] 25-08-19 16:07:34.221.379 NET: IRSCMD_DIS_LOG sent to IRSTCR(192.168.211.185)[(9100)-S] 25-08-19 16:07:34.222.013 DIS: CPU cache = L1[data]: 8KB, L1[trace]: 12Kµops, L2: 512KB 25-08-19 16:07:34.265.583 DIS: Health Monitor started 25-08-19 16:07:34.265.612 DIS: [IRSREC1] Temperature DISK #0 = 29 C (for reference only) 25-08-19 16:07:34.265.645 DIS: [IRSREC1] Temperature DISK #1 = 30 C (for reference only) 25-08-19 16:07:34.265.657 DIS: [IRSREC1] Temperature CPU1 = 32 C (allowed range:0..75) 25-08-19 16:07:34.265.666 DIS: [IRSREC1] Temperature CPU2 = 34 C (allowed range:0..75) 25-08-19 16:07:34.265.681 DIS: [IRSREC1] Temperature SYSTEM = 46 C (allowed range:0..65) 25-08-19 16:07:34.265.690 DIS: [IRSREC1] Fan Speed CPU1 = 3013 rpm (allowed range:1000..999999) 25-08-19 16:07:34.265.699 DIS: [IRSREC1] Fan Speed CPU2 = 3013 rpm (allowed range:1000..999999) 25-08-19 16:07:34.265.713 DIS: [IRSREC1] Fan Speed SYSTEM = 2376 rpm (allowed range:1000..999999) 25-08-19 16:07:34.265.726 DIS: [IRSREC1] Voltage CPU1 = 1504 mV (allowed range:1350..1760) 25-08-19 16:07:34.265.735 DIS: [IRSREC1] Voltage CPU2 = 1504 mV (allowed range:1350..1760) 25-08-19 16:07:34.265.745 DIS: [IRSREC1] Voltage +12V = 12139 mV (allowed range:10800..13200) 25-08-19 16:07:34.265.758 DIS: [IRSREC1] Voltage +5V = 5049 mV (allowed range:4500..5500) 25-08-19 16:07:34.265.769 DIS: [IRSREC1] Voltage +3.3V = 3312 mV (allowed range:2970..3630) 25-08-19 16:07:34.266.277 NET: Channel created [MSGREC1-S] 25-08-19 16:07:34.796.987 NET: Connected with IRSTCR(192.168.211.185)[MSGREC1-S] on IRSREC1(192.168.211.187) 25-08-19 16:07:34.801.846 REC: STARTUP 25-08-19 16:07:34.801.863 REC: AllocatedEx: 0.0 MB of 905.3 MB 25-08-19 16:07:34.808.279 REC: bDisableBP: 0 25-08-19 16:07:34.835.292 REC: backprojector deipan found 25-08-19 16:07:34.838.579 REC: Backprojector Boards : 2 25-08-19 16:07:34.838.609 REC: Backprojector ASICs : 8 25-08-19 16:07:34.838.732 REC: Backprojector Driver : Deipox 1.4 03/06/26 25-08-19 16:07:34.839.440 REC: Backprojector DLL : deipand.dll: 2.3 03/04/08 for DEIPOX driver 1.3 03/04/08 25-08-19 16:07:34.839.474 REC: Backprojector[0] Board : PB8 Backprojector PN 07393551 SN 08583 RV 04 25-08-19 16:07:34.839.501 REC: Backprojector[0] Firmware : Firmware Revision a01a 25-08-19 16:07:34.839.555 REC: Backprojector[0] PLX : PCI9656 Revision ad 25-08-19 16:07:34.839.578 REC: Backprojector[1] Board : PB8 Backprojector PN 07393551 SN 08689 RV 04 25-08-19 16:07:34.839.601 REC: Backprojector[1] Firmware : Firmware Revision a01a 25-08-19 16:07:34.839.646 REC: Backprojector[1] PLX : PCI9656 Revision ad 25-08-19 16:07:34.840.241 NET: Channel created [TOPXFR-S] 25-08-19 16:07:35.250.003 NET: Connected with IRSTCR(192.168.211.185)[TOPXFR-S] on IRSREC1(192.168.211.187) 25-08-19 16:07:36.837.146 LNK: Simulation = OFF 25-08-19 16:07:36.843.323 LNK: Bind adapter #1 25-08-19 16:07:36.843.463 LNK: Version = 3.24, 3.00 [NIC=1] 25-08-19 16:07:36.843.826 LNK: OID Frame = 9014 25-08-19 16:07:36.843.839 LNK: OID TX Buffer = 45060986 25-08-19 16:07:36.843.847 LNK: OID RX Buffer = 2405888 25-08-19 16:07:36.843.866 LNK: OID Max Send = 1 25-08-19 16:07:36.843.958 LNK: Frame size = 9014 25-08-19 16:07:36.844.025 LNK: Buffer size = 2371184 25-08-19 16:07:36.844.032 LNK: Send descr. = 1 25-08-19 16:07:36.844.036 LNK: Recv descr. = 264 25-08-19 16:07:36.844.041 LNK: Cmd descr. = 1 25-08-19 16:07:36.844.044 LNK: Ethernet adr. = 00005a9f2537 25-08-19 16:07:36.849.175 LNK: Common buf. type = NONE 25-08-19 16:07:36.849.187 LNK: Common buf. addr = 00000000 25-08-19 16:07:36.849.194 LNK: Common buf. size = 0 25-08-19 16:07:36.849.219 LNK: Buffer usage = 100 25-08-19 16:07:36.849.224 LNK: Connection = 36000 25-08-19 16:07:36.849.231 LNK: I/O timeout = 1000 25-08-19 16:07:36.849.236 LNK: Log all ACK = OFF 25-08-19 16:07:36.849.243 LNK: Filter = NDIS_PACKET_TYPE_BROADCAST 25-08-19 16:07:36.849.248 LNK: Compression = YES 25-08-19 16:07:36.849.252 LNK: Repeat xfer = YES 25-08-19 16:07:36.849.256 LNK: Data repeat = 4 25-08-19 16:07:36.849.261 LNK: Cmd repeat (APP) = 1 25-08-19 16:07:36.849.265 LNK: Cmd repeat (DRV) = 3 25-08-19 16:07:36.849.269 LNK: Initial CRC = 0 25-08-19 16:07:36.849.273 LNK: Initial OVL = 0 25-08-19 16:07:36.849.276 LNK: Use IOCTL CMD = YES 25-08-19 16:07:36.849.280 LNK: SCI Adapter = NO 25-08-19 16:07:36.849.438 <++ REC_DTH_CONNECT(1) 25-08-19 16:07:37.243.454 ++> REC_DTH_CONNECT_ACK(1) DTH = 00005a9f23aa 25-08-19 16:07:37.243.767 LNK: NIC Counters REC{1}-DTH: CRC=0, OVL=0 25-08-19 16:07:37.243.784 REC: LNK Version - Drv: 3.24, Lib: 3.00 25-08-19 16:07:37.243.800 LNK: SELFTEST 25-08-19 16:07:37.251.810 ... SELFTEST_START 25-08-19 16:07:37.251.846 ++> SELFTEST_START 25-08-19 16:07:37.251.861 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.252.017 ... RAW_DATA 25-08-19 16:07:37.260.030 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.260.083 ... RAW_EOT 25-08-19 16:07:37.260.205 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.260.281 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.260.302 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.260.464 ... RAW_DATA 25-08-19 16:07:37.268.416 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.268.465 ... RAW_EOT 25-08-19 16:07:37.268.578 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.268.584 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.268.596 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.268.757 ... RAW_DATA 25-08-19 16:07:37.276.770 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.276.822 ... RAW_EOT 25-08-19 16:07:37.276.914 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.276.947 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.276.960 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.277.133 ... RAW_DATA 25-08-19 16:07:37.285.117 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.285.167 ... RAW_EOT 25-08-19 16:07:37.285.266 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.285.272 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.285.285 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.285.448 ... RAW_DATA 25-08-19 16:07:37.293.440 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.293.748 ... RAW_EOT 25-08-19 16:07:37.293.771 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.293.777 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.293.787 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.294.181 ... RAW_DATA 25-08-19 16:07:37.302.069 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.302.357 ... RAW_EOT 25-08-19 16:07:37.302.381 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.302.388 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.302.398 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.302.766 ... RAW_DATA 25-08-19 16:07:37.310.869 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.311.071 ... RAW_EOT 25-08-19 16:07:37.311.303 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.311.311 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.311.322 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.311.618 ... RAW_DATA 25-08-19 16:07:37.319.685 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.319.874 ... RAW_EOT 25-08-19 16:07:37.320.092 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.320.100 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.320.111 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.320.449 ... RAW_DATA 25-08-19 16:07:37.328.486 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.328.792 ... RAW_EOT 25-08-19 16:07:37.328.814 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.328.820 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.328.830 <++ RAW_REQ{1} [IRS_REQ_PENDING, 0, 0, 800] 25-08-19 16:07:37.329.227 ... RAW_DATA 25-08-19 16:07:37.337.269 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:07:37.337.569 ... RAW_EOT 25-08-19 16:07:37.337.593 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:07:37.337.599 ++> RAW_DATA{1} [IRS_REQ_PENDING, 800, 0, 0.00, 0.00, U] 25-08-19 16:07:37.337.610 <++ RAW_REQ{1} [IRS_REQ_DONE] 25-08-19 16:07:37.337.975 ++> DONE_ACK(1) 25-08-19 16:07:37.338.208 LNK: NIC Counters REC{1}-DTH: CRC=0, OVL=0 25-08-19 16:07:39.336.811 LNK: Simulation = OFF 25-08-19 16:07:39.337.123 LNK: Bind adapter #1 25-08-19 16:07:39.337.224 LNK: Version = 3.24, 3.00 [NIC=1] 25-08-19 16:07:39.337.640 LNK: OID Frame = 1514 25-08-19 16:07:39.337.656 LNK: OID TX Buffer = 1550336 25-08-19 16:07:39.337.704 LNK: OID RX Buffer = 775168 25-08-19 16:07:39.337.711 LNK: OID Max Send = 10 25-08-19 16:07:39.337.769 LNK: Frame size = 1514 25-08-19 16:07:39.337.777 LNK: Buffer size = 755756 25-08-19 16:07:39.337.781 LNK: Send descr. = 510 25-08-19 16:07:39.337.785 LNK: Recv descr. = 1 25-08-19 16:07:39.337.791 LNK: Cmd descr. = 1 25-08-19 16:07:39.337.795 LNK: Ethernet adr. = ec086b005367 25-08-19 16:07:39.339.686 LNK: Common buf. type = NONE 25-08-19 16:07:39.339.706 LNK: Common buf. addr = 00000000 25-08-19 16:07:39.339.750 LNK: Common buf. size = 0 25-08-19 16:07:39.339.762 LNK: Buffer usage = 100 25-08-19 16:07:39.339.770 LNK: Connection = 36000 25-08-19 16:07:39.339.781 LNK: I/O timeout = 1000 25-08-19 16:07:39.339.792 LNK: Log all ACK = OFF 25-08-19 16:07:39.339.803 LNK: Filter = NDIS_PACKET_TYPE_DIRECTED 25-08-19 16:07:39.339.810 LNK: Compression = NO 25-08-19 16:07:39.339.816 LNK: Repeat xfer = YES 25-08-19 16:07:39.339.823 LNK: Data repeat = 4 25-08-19 16:07:39.339.832 LNK: Cmd repeat (APP) = 1 25-08-19 16:07:39.339.843 LNK: Cmd repeat (DRV) = 3 25-08-19 16:07:39.339.852 LNK: Initial CRC = 0 25-08-19 16:07:39.339.860 LNK: Initial OVL = 0 25-08-19 16:07:39.339.869 LNK: Use IOCTL CMD = YES 25-08-19 16:07:39.339.885 LNK: SCI Adapter = NO 25-08-19 16:07:39.340.051 <++ REC_RFM_CONNECT(1) 25-08-19 16:07:39.340.238 ++> REC_RFM_CONNECT_ACK(1) RFM = ec086b006549 25-08-19 16:07:39.340.669 LNK: NIC Counters REC{1}-RFM: CRC=0, OVL=0 25-08-19 16:07:39.340.695 LNK: SELFTEST 25-08-19 16:07:39.341.241 ... SELFTEST_START 25-08-19 16:07:39.351.665 ++> SELFTEST_START 25-08-19 16:07:39.351.739 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.351.860 ... IMAGE_HDR_RES 25-08-19 16:07:39.359.849 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.359.856 <++ IMAGE_START 25-08-19 16:07:39.367.058 <++ IMAGE 25-08-19 16:07:39.367.075 ... IMAGE_EOT 25-08-19 16:07:39.367.295 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.367.305 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.367.366 ... IMAGE_HDR_RES 25-08-19 16:07:39.374.790 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.374.798 <++ IMAGE_START 25-08-19 16:07:39.381.650 <++ IMAGE 25-08-19 16:07:39.381.668 ... IMAGE_EOT 25-08-19 16:07:39.381.878 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.381.890 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.381.950 ... IMAGE_HDR_RES 25-08-19 16:07:39.389.304 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.389.311 <++ IMAGE_START 25-08-19 16:07:39.396.163 <++ IMAGE 25-08-19 16:07:39.396.179 ... IMAGE_EOT 25-08-19 16:07:39.396.450 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.396.461 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.396.670 ... IMAGE_HDR_RES 25-08-19 16:07:39.404.028 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.404.035 <++ IMAGE_START 25-08-19 16:07:39.410.860 <++ IMAGE 25-08-19 16:07:39.410.877 ... IMAGE_EOT 25-08-19 16:07:39.411.095 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.411.141 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.411.204 ... IMAGE_HDR_RES 25-08-19 16:07:39.418.816 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.418.823 <++ IMAGE_START 25-08-19 16:07:39.426.001 <++ IMAGE 25-08-19 16:07:39.426.018 ... IMAGE_EOT 25-08-19 16:07:39.426.228 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.426.238 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.426.300 ... IMAGE_HDR_RES 25-08-19 16:07:39.433.787 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.433.794 <++ IMAGE_START 25-08-19 16:07:39.440.643 <++ IMAGE 25-08-19 16:07:39.440.661 ... IMAGE_EOT 25-08-19 16:07:39.440.862 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.440.872 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.440.933 ... IMAGE_HDR_RES 25-08-19 16:07:39.448.397 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.448.404 <++ IMAGE_START 25-08-19 16:07:39.455.522 <++ IMAGE 25-08-19 16:07:39.455.539 ... IMAGE_EOT 25-08-19 16:07:39.455.872 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.455.882 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.456.101 ... IMAGE_HDR_RES 25-08-19 16:07:39.463.805 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.463.812 <++ IMAGE_START 25-08-19 16:07:39.470.596 <++ IMAGE 25-08-19 16:07:39.470.614 ... IMAGE_EOT 25-08-19 16:07:39.470.920 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.470.931 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.471.143 ... IMAGE_HDR_RES 25-08-19 16:07:39.478.770 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.478.777 <++ IMAGE_START 25-08-19 16:07:39.485.752 <++ IMAGE 25-08-19 16:07:39.485.769 ... IMAGE_EOT 25-08-19 16:07:39.486.058 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.486.069 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:07:39.486.149 ... IMAGE_HDR_RES 25-08-19 16:07:39.493.819 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:07:39.493.826 <++ IMAGE_START 25-08-19 16:07:39.500.639 <++ IMAGE 25-08-19 16:07:39.500.656 ... IMAGE_EOT 25-08-19 16:07:39.500.928 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:07:39.500.939 <++ IMAGE_HDR [IRS_REQ_DONE] 25-08-19 16:07:39.501.412 LNK: NIC Counters REC{1}-RFM: CRC=0, OVL=0 25-08-19 16:07:39.501.503 REC: IDLE 25-08-19 16:07:39.506.799 ->> XYZ_STARTED(REC) [CT_ITH_SUCCESS] 25-08-19 16:07:39.506.853 <-- DIS_STARTUP_ACK eNlsCode = CT_ITH_SUCCESS tVersion = IRS_VB30_V8.0_32_2009AUG04_1537 eState = IRS_SENSOR_OK [IRSREC1 ] CompID = m73946660C3201413c0C [IRSREC1 ] BIOS = 02/25/05 (Date) [IRSREC1 ] CPU = 'x86 Family 15 Model 2 Stepping 9' x 4(3065 MHZ); 1022 MB [IRSREC1 ] SCSI(1) = Primary IDE Channel (ver: 5.1.2600.1106 (xpsp1.020828-1920)) [IRSREC1 ] SCSI(2) = Primary IDE Channel (ver: 5.1.2600.1106 (xpsp1.020828-1920)) [IRSREC1 ] SCSI(3) = Adaptec AIC-7902B - Ultra320 SCSI (ver: 3.0.000.000 built by: WinDDK) [IRSREC1 ] SCSI(4) = Adaptec AIC-7902B - Ultra320 SCSI (ver: 3.0.000.000 built by: WinDDK) [IRSREC1 ] NET(1) = TP-LINK Gigabit PCI Network Adapter [IRSREC1 ] NET(2) = SysKonnect SK-9821 V2.0 Gigabit Ethernet 10/100/1000Base-T Adapter, PCI64, Coppe... [IRSREC1 ] NET(3) = SysKonnect SK-9821 V2.0 Gigabit Ethernet 10/100/1000Base-T Adapter, PCI64, Coppe... [IRSREC1 ] NET(4) = Intel(R) PRO/1000 MT Network Connection [IRSREC1 ] Disks = 0:34 GB, 1:34 GB [IRSREC1 ] CPUPerf = 0:2440.3 MB/s, 1:2441.2 MB/s, 2:2438.7 MB/s, 3:2442.2 MB/s [IRSREC1 ] Health = 6.0.2:5 x86 28-May-2008 [IRSREC1 ] BP-DRV = Deipox 1.4 03/06/26 [IRSREC1 ] BP-DLL = deipand.dll: 2.3 03/04/08 for DEIPOX driver 1.3 03/04/08 [IRSREC1 ] BP0-HW = PB8 Backprojector PN 07393551 SN 08583 RV 04 [IRSREC1 ] BP0-FW = Firmware Revision a01a [IRSREC1 ] BP0-PLX = PCI9656 Revision ad [IRSREC1 ] BP1-HW = PB8 Backprojector PN 07393551 SN 08689 RV 04 [IRSREC1 ] BP1-FW = Firmware Revision a01a [IRSREC1 ] BP1-PLX = PCI9656 Revision ad [IRSREC1 ] F-LNK = Drv: 3.24, Lib: 3.00 25-08-19 16:07:39.507.072 NET: IRSCMD_DIS_STARTUP_ACK sent to IRSTCR(192.168.211.185)[(9100)-S] 25-08-19 16:07:39.507.081 IRS: READY 25-08-19 16:07:39.507.084 IRS: LOCAL PATHS: 25-08-19 16:07:39.507.172 IRS: Config dir: \\IRSTCR\IRSP30 25-08-19 16:07:39.507.235 IRS: Raw data dir: \\IRSAQP\IRSP30.DAT 25-08-19 16:07:39.507.292 IRS: Tables dir: \\IRSTCR\IRSP30.TBL 25-08-19 16:07:39.507.395 IRS: Volumes dir: \\IRSTCR\IRSP30.VOL 25-08-19 16:12:46.777.445 NET: IRSCMD_DIS_INIT received from IRSTCR(192.168.211.185)[(9100)-S] (data=24 B) 25-08-19 16:12:46.342.002 --> DIS_INIT Time = 25-08-2019 16:12:46.342 HWRev = 00000001 25-08-19 16:12:46.342.069 IRS: IDLE 25-08-19 16:15:23.927.397 NET: IRSCMD_TCR_LOAD received from IRSTCR(192.168.211.185)[MSGREC1-S] (data=1360 B) 25-08-19 16:15:24.154.767 --> TCR_REC_LOAD 'vzn-------------------------20190825-161523-0001-0716506C-00000' 25-08-19 16:15:24.155.161 REC: LOAD 25-08-19 16:15:24.174.963 BSC: IrsBsc_VolPar_SetRept: iRept: 0 (0), nRept: 1 (1), iImaFirstNumInRept: 1 (0), iImaMaxNumInRept: 1 (0), iNumberOfImagesInRept: 1 25-08-19 16:15:24.175.200 LNK: IoTimeout = 500 (prev=1000) 25-08-19 16:15:24.175.210 LNK: IoTimeout = 500 (prev=1000) 25-08-19 16:15:24.188.229 BSC: TABLE ACCESS: 'convkernel.30.T20s' [LastUpdate 1998-05-13 11:48, Version 0.10](15 ms) 25-08-19 16:15:24.192.044 BSC: TABLE ACCESS: 'AEC' [LastUpdate 2006-06-08 06:43, Version 1.31](0 ms) 25-08-19 16:15:24.192.140 REC: Pipeline started: TOPOGRAM 25-08-19 16:15:24.192.187 REC: EXEC 25-08-19 16:15:24.192.574 <++ RAW_OPEN{1} [IRS_REQ_PENDING, vzn-------------------------20190825-161523-0000-07165030-00000, 1, 672, FUS(-), FULL, ASYNCH] 25-08-19 16:15:24.192.982 REC: TOPO thread started 25-08-19 16:15:24.193.054 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:43.872.006 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 0, 349.68, 349.68, C] 25-08-19 16:15:43.872.039 --> DTH_REC_DATA (TOPO 0, 8) 25-08-19 16:15:43.872.049 REC: DATA> ----- 25-08-19 16:15:43.872.066 REC: ----- >DATA 25-08-19 16:15:43.873.288 <-- REC_IMA_TOPO_BEG 25-08-19 16:15:43.873.396 NET: IRSCMD_REC_TOPO_BEG sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:43.873.487 REC: lower limit for AttenP2ProjDirLat 0.000 set to 2.212 25-08-19 16:15:43.884.464 REC: lower limit for AttenInProjDir 1069.5 set to 1147.2 25-08-19 16:15:43.884.486 REC: lower limit for AttenP2ProjDirLat 0.000 set to 2.212 25-08-19 16:15:43.885.617 REC: lower limit for AttenInProjDir 1065.2 set to 1147.2 25-08-19 16:15:43.885.640 REC: lower limit for AttenP2ProjDirLat 0.000 set to 2.212 25-08-19 16:15:43.885.676 REC: lower limit for AttenInProjDir 1055.0 set to 1147.2 25-08-19 16:15:43.885.723 REC: lower limit for AttenP2ProjDirLat 0.000 set to 2.212 25-08-19 16:15:43.885.803 REC: lower limit for AttenP2ProjDirLat 0.000 set to 2.212 25-08-19 16:15:43.885.976 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:43.979.383 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 459, 349.68, 349.68, C] 25-08-19 16:15:43.979.419 --> DTH_REC_DATA (TOPO 8, 8) 25-08-19 16:15:43.979.430 REC: DATA> ----- 25-08-19 16:15:43.979.436 REC: ----- >DATA 25-08-19 16:15:43.979.753 <-- REC_IMA_TOPO_DATA(0-3) 25-08-19 16:15:43.979.797 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:43.980.165 <-- REC_IMA_TOPO_DATA(4-7) 25-08-19 16:15:43.980.199 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:43.980.312 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.130.181 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 774, 349.68, 349.68, C] 25-08-19 16:15:44.130.216 --> DTH_REC_DATA (TOPO 16, 8) 25-08-19 16:15:44.130.229 REC: DATA> ----- 25-08-19 16:15:44.130.235 REC: ----- >DATA 25-08-19 16:15:44.130.522 <-- REC_IMA_TOPO_DATA(8-11) 25-08-19 16:15:44.130.568 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.130.895 <-- REC_IMA_TOPO_DATA(12-15) 25-08-19 16:15:44.130.934 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.131.001 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.173.388 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 1016, 349.68, 349.68, C] 25-08-19 16:15:44.173.418 --> DTH_REC_DATA (TOPO 24, 8) 25-08-19 16:15:44.173.429 REC: DATA> ----- 25-08-19 16:15:44.173.434 REC: ----- >DATA 25-08-19 16:15:44.173.717 <-- REC_IMA_TOPO_DATA(16-19) 25-08-19 16:15:44.173.764 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.174.082 <-- REC_IMA_TOPO_DATA(20-23) 25-08-19 16:15:44.174.130 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.174.165 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.280.903 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 1220, 349.68, 349.68, C] 25-08-19 16:15:44.280.935 --> DTH_REC_DATA (TOPO 32, 8) 25-08-19 16:15:44.280.947 REC: DATA> ----- 25-08-19 16:15:44.280.952 REC: ----- >DATA 25-08-19 16:15:44.281.237 <-- REC_IMA_TOPO_DATA(24-27) 25-08-19 16:15:44.281.280 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.281.617 <-- REC_IMA_TOPO_DATA(28-31) 25-08-19 16:15:44.281.657 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.281.703 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.324.137 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 1407, 349.68, 349.68, C] 25-08-19 16:15:44.324.177 --> DTH_REC_DATA (TOPO 40, 8) 25-08-19 16:15:44.324.189 REC: DATA> ----- 25-08-19 16:15:44.324.194 REC: ----- >DATA 25-08-19 16:15:44.324.477 <-- REC_IMA_TOPO_DATA(32-35) 25-08-19 16:15:44.324.517 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.324.897 <-- REC_IMA_TOPO_DATA(36-39) 25-08-19 16:15:44.324.959 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.324.995 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.431.700 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 1592, 349.68, 349.68, C] 25-08-19 16:15:44.431.738 --> DTH_REC_DATA (TOPO 48, 8) 25-08-19 16:15:44.431.750 REC: DATA> ----- 25-08-19 16:15:44.431.755 REC: ----- >DATA 25-08-19 16:15:44.432.036 <-- REC_IMA_TOPO_DATA(40-43) 25-08-19 16:15:44.432.076 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.432.373 <-- REC_IMA_TOPO_DATA(44-47) 25-08-19 16:15:44.432.425 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.432.458 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.539.338 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 1778, 349.68, 349.68, C] 25-08-19 16:15:44.539.424 --> DTH_REC_DATA (TOPO 56, 8) 25-08-19 16:15:44.539.444 REC: DATA> ----- 25-08-19 16:15:44.539.449 REC: ----- >DATA 25-08-19 16:15:44.539.738 <-- REC_IMA_TOPO_DATA(48-51) 25-08-19 16:15:44.539.791 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.540.115 <-- REC_IMA_TOPO_DATA(52-55) 25-08-19 16:15:44.540.156 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.540.191 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.582.623 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 1963, 349.68, 349.68, C] 25-08-19 16:15:44.582.662 --> DTH_REC_DATA (TOPO 64, 8) 25-08-19 16:15:44.582.674 REC: DATA> ----- 25-08-19 16:15:44.582.679 REC: ----- >DATA 25-08-19 16:15:44.582.960 <-- REC_IMA_TOPO_DATA(56-59) 25-08-19 16:15:44.583.001 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.583.327 <-- REC_IMA_TOPO_DATA(60-63) 25-08-19 16:15:44.583.364 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.583.431 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.690.365 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 2149, 349.68, 349.68, C] 25-08-19 16:15:44.690.397 --> DTH_REC_DATA (TOPO 72, 8) 25-08-19 16:15:44.690.408 REC: DATA> ----- 25-08-19 16:15:44.690.412 REC: ----- >DATA 25-08-19 16:15:44.690.700 <-- REC_IMA_TOPO_DATA(64-67) 25-08-19 16:15:44.690.749 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.691.069 <-- REC_IMA_TOPO_DATA(68-71) 25-08-19 16:15:44.691.106 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.691.137 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.733.474 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 2334, 349.68, 349.68, C] 25-08-19 16:15:44.733.508 --> DTH_REC_DATA (TOPO 80, 8) 25-08-19 16:15:44.733.518 REC: DATA> ----- 25-08-19 16:15:44.733.523 REC: ----- >DATA 25-08-19 16:15:44.733.806 <-- REC_IMA_TOPO_DATA(72-75) 25-08-19 16:15:44.733.846 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.734.164 <-- REC_IMA_TOPO_DATA(76-79) 25-08-19 16:15:44.734.201 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.734.234 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.819.898 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 2520, 349.68, 349.68, C] 25-08-19 16:15:44.819.932 --> DTH_REC_DATA (TOPO 88, 8) 25-08-19 16:15:44.819.942 REC: DATA> ----- 25-08-19 16:15:44.819.947 REC: ----- >DATA 25-08-19 16:15:44.820.225 <-- REC_IMA_TOPO_DATA(80-83) 25-08-19 16:15:44.820.268 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.820.627 <-- REC_IMA_TOPO_DATA(84-87) 25-08-19 16:15:44.820.668 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.820.698 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.927.481 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 2705, 349.68, 349.68, C] 25-08-19 16:15:44.927.540 --> DTH_REC_DATA (TOPO 96, 8) 25-08-19 16:15:44.927.556 REC: DATA> ----- 25-08-19 16:15:44.927.565 REC: ----- >DATA 25-08-19 16:15:44.927.849 <-- REC_IMA_TOPO_DATA(88-91) 25-08-19 16:15:44.927.890 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.928.186 <-- REC_IMA_TOPO_DATA(92-95) 25-08-19 16:15:44.928.225 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.928.258 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:44.970.882 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 2891, 349.68, 349.68, C] 25-08-19 16:15:44.970.916 --> DTH_REC_DATA (TOPO 104, 8) 25-08-19 16:15:44.970.929 REC: DATA> ----- 25-08-19 16:15:44.970.935 REC: ----- >DATA 25-08-19 16:15:44.971.224 <-- REC_IMA_TOPO_DATA(96-99) 25-08-19 16:15:44.971.263 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.971.584 <-- REC_IMA_TOPO_DATA(100-103) 25-08-19 16:15:44.971.623 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:44.971.666 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.078.484 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 3076, 349.68, 349.68, C] 25-08-19 16:15:45.078.515 --> DTH_REC_DATA (TOPO 112, 8) 25-08-19 16:15:45.078.527 REC: DATA> ----- 25-08-19 16:15:45.078.532 REC: ----- >DATA 25-08-19 16:15:45.078.814 <-- REC_IMA_TOPO_DATA(104-107) 25-08-19 16:15:45.078.886 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.079.218 <-- REC_IMA_TOPO_DATA(108-111) 25-08-19 16:15:45.079.284 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.079.319 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.121.609 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 3262, 349.68, 349.68, C] 25-08-19 16:15:45.121.653 --> DTH_REC_DATA (TOPO 120, 8) 25-08-19 16:15:45.121.666 REC: DATA> ----- 25-08-19 16:15:45.121.670 REC: ----- >DATA 25-08-19 16:15:45.121.951 <-- REC_IMA_TOPO_DATA(112-115) 25-08-19 16:15:45.121.993 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.122.325 <-- REC_IMA_TOPO_DATA(116-119) 25-08-19 16:15:45.122.369 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.122.428 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.229.206 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 3447, 349.68, 349.68, C] 25-08-19 16:15:45.229.239 --> DTH_REC_DATA (TOPO 128, 8) 25-08-19 16:15:45.229.257 REC: DATA> ----- 25-08-19 16:15:45.229.261 REC: ----- >DATA 25-08-19 16:15:45.229.541 <-- REC_IMA_TOPO_DATA(120-123) 25-08-19 16:15:45.229.582 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.229.877 <-- REC_IMA_TOPO_DATA(124-127) 25-08-19 16:15:45.229.919 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.229.988 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.336.708 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 3633, 349.68, 349.68, C] 25-08-19 16:15:45.336.766 --> DTH_REC_DATA (TOPO 136, 8) 25-08-19 16:15:45.336.781 REC: DATA> ----- 25-08-19 16:15:45.336.786 REC: ----- >DATA 25-08-19 16:15:45.337.069 <-- REC_IMA_TOPO_DATA(128-131) 25-08-19 16:15:45.337.117 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.337.418 <-- REC_IMA_TOPO_DATA(132-135) 25-08-19 16:15:45.337.460 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.337.513 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.380.271 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 3818, 349.68, 349.68, C] 25-08-19 16:15:45.380.303 --> DTH_REC_DATA (TOPO 144, 8) 25-08-19 16:15:45.380.321 REC: DATA> ----- 25-08-19 16:15:45.380.325 REC: ----- >DATA 25-08-19 16:15:45.380.608 <-- REC_IMA_TOPO_DATA(136-139) 25-08-19 16:15:45.380.646 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.380.965 <-- REC_IMA_TOPO_DATA(140-143) 25-08-19 16:15:45.381.023 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.381.058 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.487.914 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 4004, 349.68, 349.68, C] 25-08-19 16:15:45.487.946 --> DTH_REC_DATA (TOPO 152, 8) 25-08-19 16:15:45.487.958 REC: DATA> ----- 25-08-19 16:15:45.487.962 REC: ----- >DATA 25-08-19 16:15:45.488.244 <-- REC_IMA_TOPO_DATA(144-147) 25-08-19 16:15:45.488.290 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.488.623 <-- REC_IMA_TOPO_DATA(148-151) 25-08-19 16:15:45.488.661 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.488.695 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.531.047 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 4189, 349.68, 349.68, C] 25-08-19 16:15:45.531.082 --> DTH_REC_DATA (TOPO 160, 8) 25-08-19 16:15:45.531.098 REC: DATA> ----- 25-08-19 16:15:45.531.102 REC: ----- >DATA 25-08-19 16:15:45.531.381 <-- REC_IMA_TOPO_DATA(152-155) 25-08-19 16:15:45.531.412 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.531.743 <-- REC_IMA_TOPO_DATA(156-159) 25-08-19 16:15:45.531.815 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.531.847 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.638.628 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 4375, 349.68, 349.68, C] 25-08-19 16:15:45.638.660 --> DTH_REC_DATA (TOPO 168, 8) 25-08-19 16:15:45.638.670 REC: DATA> ----- 25-08-19 16:15:45.638.674 REC: ----- >DATA 25-08-19 16:15:45.638.954 <-- REC_IMA_TOPO_DATA(160-163) 25-08-19 16:15:45.638.995 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.639.306 <-- REC_IMA_TOPO_DATA(164-167) 25-08-19 16:15:45.639.343 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.639.375 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.725.171 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 4561, 349.68, 349.68, C] 25-08-19 16:15:45.725.205 --> DTH_REC_DATA (TOPO 176, 8) 25-08-19 16:15:45.725.216 REC: DATA> ----- 25-08-19 16:15:45.725.220 REC: ----- >DATA 25-08-19 16:15:45.725.499 <-- REC_IMA_TOPO_DATA(168-171) 25-08-19 16:15:45.725.539 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.725.848 <-- REC_IMA_TOPO_DATA(172-175) 25-08-19 16:15:45.725.899 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.725.932 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.789.489 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 4746, 349.68, 349.68, C] 25-08-19 16:15:45.789.523 --> DTH_REC_DATA (TOPO 184, 8) 25-08-19 16:15:45.789.533 REC: DATA> ----- 25-08-19 16:15:45.789.537 REC: ----- >DATA 25-08-19 16:15:45.789.813 <-- REC_IMA_TOPO_DATA(176-179) 25-08-19 16:15:45.789.852 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.790.166 <-- REC_IMA_TOPO_DATA(180-183) 25-08-19 16:15:45.790.205 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.790.240 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.875.940 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 4932, 349.68, 349.68, C] 25-08-19 16:15:45.875.975 --> DTH_REC_DATA (TOPO 192, 8) 25-08-19 16:15:45.875.985 REC: DATA> ----- 25-08-19 16:15:45.875.991 REC: ----- >DATA 25-08-19 16:15:45.876.272 <-- REC_IMA_TOPO_DATA(184-187) 25-08-19 16:15:45.876.316 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.876.610 <-- REC_IMA_TOPO_DATA(188-191) 25-08-19 16:15:45.876.650 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.876.705 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:45.941.954 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 5117, 349.68, 349.68, C] 25-08-19 16:15:45.941.985 --> DTH_REC_DATA (TOPO 200, 8) 25-08-19 16:15:45.941.996 REC: DATA> ----- 25-08-19 16:15:45.942.001 REC: ----- >DATA 25-08-19 16:15:45.942.280 <-- REC_IMA_TOPO_DATA(192-195) 25-08-19 16:15:45.942.327 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.942.619 <-- REC_IMA_TOPO_DATA(196-199) 25-08-19 16:15:45.942.662 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:45.942.718 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.026.792 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 5303, 349.68, 349.68, C] 25-08-19 16:15:46.026.828 --> DTH_REC_DATA (TOPO 208, 8) 25-08-19 16:15:46.026.839 REC: DATA> ----- 25-08-19 16:15:46.026.845 REC: ----- >DATA 25-08-19 16:15:46.027.124 <-- REC_IMA_TOPO_DATA(200-203) 25-08-19 16:15:46.027.164 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.027.498 <-- REC_IMA_TOPO_DATA(204-207) 25-08-19 16:15:46.027.536 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.027.598 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.134.449 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 5488, 349.68, 349.68, C] 25-08-19 16:15:46.134.482 --> DTH_REC_DATA (TOPO 216, 8) 25-08-19 16:15:46.134.495 REC: DATA> ----- 25-08-19 16:15:46.134.499 REC: ----- >DATA 25-08-19 16:15:46.134.782 <-- REC_IMA_TOPO_DATA(208-211) 25-08-19 16:15:46.134.827 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.135.140 <-- REC_IMA_TOPO_DATA(212-215) 25-08-19 16:15:46.135.179 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.135.213 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.177.652 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 5674, 349.68, 349.68, C] 25-08-19 16:15:46.177.681 --> DTH_REC_DATA (TOPO 224, 8) 25-08-19 16:15:46.177.694 REC: DATA> ----- 25-08-19 16:15:46.177.698 REC: ----- >DATA 25-08-19 16:15:46.178.023 <-- REC_IMA_TOPO_DATA(216-219) 25-08-19 16:15:46.178.053 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.178.396 <-- REC_IMA_TOPO_DATA(220-223) 25-08-19 16:15:46.178.437 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.178.472 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.285.360 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 5859, 349.68, 349.68, C] 25-08-19 16:15:46.285.395 --> DTH_REC_DATA (TOPO 232, 8) 25-08-19 16:15:46.285.412 REC: DATA> ----- 25-08-19 16:15:46.285.417 REC: ----- >DATA 25-08-19 16:15:46.285.700 <-- REC_IMA_TOPO_DATA(224-227) 25-08-19 16:15:46.285.741 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.286.038 <-- REC_IMA_TOPO_DATA(228-231) 25-08-19 16:15:46.286.077 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.286.123 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.328.522 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 6045, 349.68, 349.68, C] 25-08-19 16:15:46.328.555 --> DTH_REC_DATA (TOPO 240, 8) 25-08-19 16:15:46.328.567 REC: DATA> ----- 25-08-19 16:15:46.328.571 REC: ----- >DATA 25-08-19 16:15:46.328.847 <-- REC_IMA_TOPO_DATA(232-235) 25-08-19 16:15:46.328.889 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.329.215 <-- REC_IMA_TOPO_DATA(236-239) 25-08-19 16:15:46.329.251 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.329.284 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.349.845 ++> RAW_DATA{1} [IRS_REQ_PENDING, 8, 6230, 349.68, 349.68, C] 25-08-19 16:15:46.349.874 --> DTH_REC_DATA (TOPO 248, 8) 25-08-19 16:15:46.349.886 REC: DATA> ----- 25-08-19 16:15:46.349.894 REC: ----- >DATA 25-08-19 16:15:46.349.890 REC: Enough projections read: LinesReadIn-PrelimLines: 256, TopoLength: 256 25-08-19 16:15:46.349.909 REC: Topo end reached, Counter1: 248, TopoMax: 256, ProjsToProcess: 8 25-08-19 16:15:46.353.601 <-- REC_IMA_TOPO_DATA(240-243) 25-08-19 16:15:46.353.652 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.354.012 <-- REC_IMA_TOPO_DATA(244-247) 25-08-19 16:15:46.354.051 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.354.155 <-- REC_IMA_TOPO_DATA(248-251) 25-08-19 16:15:46.354.191 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.354.335 <-- REC_IMA_TOPO_DATA(252-255) 25-08-19 16:15:46.354.391 NET: IRSCMD_REC_TOPO_DATA sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.354.420 <-- REC_IMA_TOPO_END 25-08-19 16:15:46.354.433 REC: Topo_End: nVectors 256, AEC lines 256 25-08-19 16:15:46.354.517 NET: IRSCMD_REC_TOPO_END sent to IRSTCR(192.168.211.185)[TOPXFR-S] 25-08-19 16:15:46.354.541 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:15:46.355.309 ++> RAW_DATA{1} [IRS_REQ_DONE, 2, 6416, 349.68, 349.68, ] 25-08-19 16:15:46.355.373 --> DTH_REC_DONE 25-08-19 16:15:46.355.383 --> DTH_REC_DATA (TOPO 256, 2) 25-08-19 16:15:46.355.395 REC: DATA> ----- 25-08-19 16:15:46.355.399 REC: Enough projections read: LinesReadIn-PrelimLines: 258, TopoLength: 256 25-08-19 16:15:46.355.409 <-- REC_DTH_DONE 25-08-19 16:15:46.355.415 <++ RAW_REQ{1} [IRS_REQ_DONE] 25-08-19 16:15:46.355.501 ++> DONE_ACK(1) 25-08-19 16:15:46.355.809 REC: COMPLETE 25-08-19 16:15:46.356.109 <-- REC_TCR_END{1} 'vzn-------------------------20190825-161523-0001-0716506C-00000' [CT_ITH_SUCCESS,IRS_REQ_DONE] 25-08-19 16:15:46.356.209 NET: IRSCMD_REC_END sent to IRSTCR(192.168.211.185)[MSGREC1-S] 25-08-19 16:15:46.356.304 REC: IDLE 25-08-19 16:16:07.202.872 NET: IRSCMD_TCR_LOAD received from IRSTCR(192.168.211.185)[MSGREC1-S] (data=1360 B) 25-08-19 16:16:07.461.670 --> TCR_REC_LOAD 'vzn-------------------------20190825-161607-0003-0716506C-00000' 25-08-19 16:16:07.462.029 REC: LOAD 25-08-19 16:16:07.462.369 BSC: IrsBsc_VolPar_SetRept: iRept: 0 (0), nRept: 1 (1), iImaFirstNumInRept: 1 (1), iImaMaxNumInRept: 36 (36), iNumberOfImagesInRept: 36 25-08-19 16:16:07.470.233 LNK: IoTimeout = 1000 (prev=500) 25-08-19 16:16:07.470.245 LNK: IoTimeout = 1000 (prev=500) 25-08-19 16:16:07.471.260 REC: Modified .LinesAfterPrep: 8 25-08-19 16:16:07.474.703 REC: Modified .SliceDistance: 1500 25-08-19 16:16:07.474.718 REC: Modified .SliceWidth: 1500 25-08-19 16:16:07.481.307 REC: act_conv_threads=1 pbux=32 act_pfo_threads=4 25-08-19 16:16:07.481.328 REC: doradipol = 1 25-08-19 16:16:07.481.333 REC: allocate backend buffer 11 MB 25-08-19 16:16:07.487.006 REC: pbfluorosub=4 25-08-19 16:16:07.487.015 REC: load kernel 25-08-19 16:16:07.493.128 BSC: TABLE ACCESS: 'convkernel.30.H30s' [LastUpdate 2003-05-08 09:37, Version 0.00](16 ms) 25-08-19 16:16:07.494.222 REC: load moire 25-08-19 16:16:07.496.934 BSC: TABLE ACCESS: 'moire_norm_s' [LastUpdate 2003-04-09 08:07, Version 0.00](0 ms) 25-08-19 16:16:07.497.127 REC: nChanConv=1294 nChanBp=2587 obchanext=96 25-08-19 16:16:07.497.530 REC: pbsynchron = 1 25-08-19 16:16:07.500.792 REC: BufferDump: 0x0 25-08-19 16:16:07.500.811 REC: act_reb_threads=4 25-08-19 16:16:07.500.822 REC: donewrebin=0 25-08-19 16:16:07.500.826 REC: hitbyrebin = 168 25-08-19 16:16:07.500.830 REC: allocate frontend buffer 137 kB 25-08-19 16:16:07.500.986 REC: rmissing = 6 rdelay = 6 rmax = 2306 25-08-19 16:16:07.500.994 REC: tabledirection=1 feedperreading=4.39655 25-08-19 16:16:07.501.086 REC: InputBlocksize: 232 readings 25-08-19 16:16:07.504.543 REC: load spiral_width table spiral_width_recon_8_16x750_3000 25-08-19 16:16:07.504.606 BSC: TABLE ACCESS: 'spiral_width_recon_8_16x750_3000' [LastUpdate 2004-07-19 12:00, Version 1.20](0 ms) 25-08-19 16:16:07.504.665 REC: AllocEx: 0.0 MB of 905.3 MB 25-08-19 16:16:07.625.266 BSC: TABLE ACCESS: 'spiral_width_recon_8_16x750_3000' [LastUpdate 2004-07-19 12:00, Version 1.20](0 ms) 25-08-19 16:16:07.627.648 REC: load spiral_base table spiral_base_recon_trap04 25-08-19 16:16:07.628.000 BSC: TABLE ACCESS: 'spiral_base_recon_trap04' [LastUpdate 2001-09-10 12:06, Version 1.00](0 ms) 25-08-19 16:16:07.839.584 REC: Buffer INP: 31.8 MB, 3016 rdngs 25-08-19 16:16:07.839.629 REC: Buffer INT: 47.7 MB, 2320 rdngs 25-08-19 16:16:07.839.640 REC: Buffer AZI: 90.5 MB, 2204 projs 25-08-19 16:16:07.839.649 REC: Buffer COM: 3.0 MB (* 4), 581 projs each 25-08-19 16:16:07.839.658 REC: Buffer IMA: 0.5 MB (* 2), 512 lines each 25-08-19 16:16:07.839.664 REC: GrandTotal: 212.8 MB 25-08-19 16:16:07.839.674 REC: Pipeline started: SLICE 25-08-19 16:16:07.839.678 REC: EXEC 25-08-19 16:16:07.841.309 <++ RAW_OPEN{1} [IRS_REQ_PENDING, vzn-------------------------20190825-161607-0002-07165030-00000, 16, 672, FUS_S(0-16:x2), FULL, ASYNCH] 25-08-19 16:16:07.841.736 REC: ..... ..... ..... ?DATA 25-08-19 16:16:07.842.745 REC: FE >List group 0 25-08-19 16:16:07.842.821 REC: FE Grp NEW, Descr[0].[Scan 0, Start 1020, Enq 1, Rcvd 0] 25-08-19 16:16:07.842.854 REC: ----- Begin r0 l0 Enquires 1 of 1 [Scan 0, Start 1020, Rcvd 0] 25-08-19 16:16:07.883.699 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 1020, 1] 25-08-19 16:16:07.883.772 ... RAW_DATA 25-08-19 16:16:24.183.579 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:24.183.645 ... RAW_EOT 25-08-19 16:16:24.183.745 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.183.752 ++> RAW_DATA{1} [IRS_REQ_PENDING, 1, 1020, 256.66, 0.00, C] 25-08-19 16:16:24.183.778 REC: INP< Received 1 25-08-19 16:16:24.183.785 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.183.794 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.183.798 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.183.815 REC: RCVD? ..... ..... ..... [uDes=0 uStart=0] 25-08-19 16:16:24.183.813 REC: FE SAM ZSample -1015900, exp. -1015783, DeltaZ 117, DeltaRdg 25 25-08-19 16:16:24.183.827 REC: RCVD< ----- ----- ----- 25-08-19 16:16:24.183.834 REC: RCVD? ..... ..... ..... [uDes=0 uStart=0] 25-08-19 16:16:24.183.831 REC: FE Grp NEW, Descr[1].[Scan 0, Start 1020, Enq 2784, Rcvd 0] 25-08-19 16:16:24.183.851 REC: ----- ----- ----- ----- 25-08-19 16:16:24.183.874 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.183.879 REC: ..... ?DATA ..... ..... {Rebin} 25-08-19 16:16:24.183.877 REC: INP> Begin r0 l0 Enquires 232 of 2784 [Scan 0, Start 1020, Rcvd 0] 25-08-19 16:16:24.183.890 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 1020, 232] 25-08-19 16:16:24.184.126 ... RAW_DATA 25-08-19 16:16:24.296.921 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:24.296.997 ... RAW_EOT 25-08-19 16:16:24.297.108 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.297.181 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 1020, 256.66, 256.81, CC] 25-08-19 16:16:24.297.211 REC: INP< Received 232 25-08-19 16:16:24.297.223 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.297.240 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.297.240 REC: INP> Begin r232 l232 Enquires 232 of 2552 [Scan 0, Start 1020, Rcvd 232] 25-08-19 16:16:24.297.271 REC: FE >Rebin in: N[0 231], #232 25-08-19 16:16:24.297.272 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 1252, 232] 25-08-19 16:16:24.297.656 ... RAW_DATA 25-08-19 16:16:24.298.205 REC: firstcall=1: reset all front end buffers 25-08-19 16:16:24.310.635 REC: input=232 internal=232 balfront=232 balready=232 adaptready=232 fusedready=232 rebinfront=232 output=113 25-08-19 16:16:24.310.675 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.375.284 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 1252, 292.66, 292.81, CC] 25-08-19 16:16:24.375.311 REC: INP< Received 232 25-08-19 16:16:24.375.321 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.375.335 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.375.335 REC: INP> Begin r464 l464 Enquires 232 of 2320 [Scan 0, Start 1020, Rcvd 464] 25-08-19 16:16:24.375.353 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 1484, 232] 25-08-19 16:16:24.375.354 REC: FE >Rebin in: N[232 463], #232 25-08-19 16:16:24.376.034 ... RAW_DATA 25-08-19 16:16:24.388.495 REC: input=464 internal=464 balfront=464 balready=464 adaptready=464 fusedready=464 rebinfront=464 output=229 25-08-19 16:16:24.388.535 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.445.169 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 1484, 328.66, 328.81, CC] 25-08-19 16:16:24.445.200 REC: INP< Received 232 25-08-19 16:16:24.445.211 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.445.232 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.445.237 REC: INP> Begin r696 l696 Enquires 232 of 2088 [Scan 0, Start 1020, Rcvd 696] 25-08-19 16:16:24.445.251 REC: FE >Rebin in: N[464 695], #232 25-08-19 16:16:24.445.251 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 1716, 232] 25-08-19 16:16:24.445.898 ... RAW_DATA 25-08-19 16:16:24.458.357 REC: input=696 internal=696 balfront=696 balready=696 adaptready=696 fusedready=696 rebinfront=696 output=345 25-08-19 16:16:24.458.397 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.521.783 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 1716, 4.66, 4.81, CC] 25-08-19 16:16:24.521.815 REC: INP< Received 232 25-08-19 16:16:24.521.828 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.521.843 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.521.845 REC: INP> Begin r928 l928 Enquires 232 of 1856 [Scan 0, Start 1020, Rcvd 928] 25-08-19 16:16:24.521.875 REC: FE >Rebin in: N[696 927], #232 25-08-19 16:16:24.521.877 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 1948, 232] 25-08-19 16:16:24.522.475 ... RAW_DATA 25-08-19 16:16:24.535.048 REC: input=928 internal=928 balfront=928 balready=928 adaptready=928 fusedready=928 rebinfront=928 output=461 25-08-19 16:16:24.535.088 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.602.722 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 1948, 40.66, 40.81, CC] 25-08-19 16:16:24.602.750 REC: INP< Received 232 25-08-19 16:16:24.602.759 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.602.771 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.602.774 REC: INP> Begin r1160 l1160 Enquires 232 of 1624 [Scan 0, Start 1020, Rcvd 1160] 25-08-19 16:16:24.602.792 REC: FE >Rebin in: N[928 1159], #232 25-08-19 16:16:24.602.793 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 2180, 232] 25-08-19 16:16:24.603.461 ... RAW_DATA 25-08-19 16:16:24.615.915 REC: input=1160 internal=1160 balfront=1160 balready=1160 adaptready=1160 fusedready=1160 rebinfront=1160 output=577 25-08-19 16:16:24.615.953 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.671.078 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 2180, 76.66, 76.81, CC] 25-08-19 16:16:24.671.109 REC: INP< Received 232 25-08-19 16:16:24.671.122 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.671.142 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.671.145 REC: INP> Begin r1392 l1392 Enquires 232 of 1392 [Scan 0, Start 1020, Rcvd 1392] 25-08-19 16:16:24.671.159 REC: FE >Rebin in: N[1160 1391], #232 25-08-19 16:16:24.671.161 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 2412, 232] 25-08-19 16:16:24.671.793 ... RAW_DATA 25-08-19 16:16:24.684.296 REC: input=1392 internal=1392 balfront=1392 balready=1392 adaptready=1392 fusedready=1392 rebinfront=1392 output=693 25-08-19 16:16:24.684.335 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.747.561 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 2412, 112.66, 112.81, CC] 25-08-19 16:16:24.747.640 REC: INP< Received 232 25-08-19 16:16:24.747.652 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.747.669 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.747.671 REC: INP> Begin r1624 l1624 Enquires 232 of 1160 [Scan 0, Start 1020, Rcvd 1624] 25-08-19 16:16:24.747.686 REC: FE >Rebin in: N[1392 1623], #232 25-08-19 16:16:24.747.687 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 2644, 232] 25-08-19 16:16:24.748.313 ... RAW_DATA 25-08-19 16:16:24.760.782 REC: input=1624 internal=1624 balfront=1624 balready=1624 adaptready=1624 fusedready=1624 rebinfront=1624 output=809 25-08-19 16:16:24.760.824 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.827.769 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 2644, 148.66, 148.81, CC] 25-08-19 16:16:24.827.798 REC: INP< Received 232 25-08-19 16:16:24.827.808 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.827.828 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.827.829 REC: INP> Begin r1856 l1856 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 1856] 25-08-19 16:16:24.827.847 REC: FE >Rebin in: N[1624 1705], #82 25-08-19 16:16:24.827.904 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 2876, 232] 25-08-19 16:16:24.828.510 ... RAW_DATA 25-08-19 16:16:24.832.884 REC: input=1706 internal=1706 balfront=1706 balready=1706 adaptready=1706 fusedready=1706 rebinfront=1706 output=850 25-08-19 16:16:24.832.924 REC: FE Rebin in: N[1706 1855], #150 25-08-19 16:16:24.841.446 REC: input=1856 internal=1856 balfront=1856 balready=1856 adaptready=1856 fusedready=1856 rebinfront=1856 output=925 25-08-19 16:16:24.841.487 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.896.866 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 2876, 184.66, 184.81, CC] 25-08-19 16:16:24.896.973 REC: INP< Received 232 25-08-19 16:16:24.896.986 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.897.001 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.897.006 REC: INP> Begin r2088 l2088 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 2088] 25-08-19 16:16:24.897.020 REC: FE >Rebin in: N[1856 2087], #232 25-08-19 16:16:24.897.020 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 3108, 232] 25-08-19 16:16:24.897.554 ... RAW_DATA 25-08-19 16:16:24.910.210 REC: input=2088 internal=2088 balfront=2088 balready=2088 adaptready=2088 fusedready=2088 rebinfront=2088 output=1041 25-08-19 16:16:24.910.253 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:24.972.735 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 3108, 220.66, 220.81, CC] 25-08-19 16:16:24.972.763 REC: INP< Received 232 25-08-19 16:16:24.972.773 REC: DATA> ----- ----- ----- 25-08-19 16:16:24.972.790 REC: ----- >DATA ----- ----- 25-08-19 16:16:24.972.801 REC: INP> Begin r2320 l2320 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 2320] 25-08-19 16:16:24.972.817 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 3340, 232] 25-08-19 16:16:24.972.819 REC: FE >Rebin in: N[2088 2319], #232 25-08-19 16:16:24.973.414 ... RAW_DATA 25-08-19 16:16:24.985.955 REC: input=2320 internal=2320 balfront=2320 balready=2320 adaptready=2320 fusedready=2320 rebinfront=2320 output=1157 25-08-19 16:16:24.985.994 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.042.923 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 3340, 256.66, 256.81, CC] 25-08-19 16:16:25.042.954 REC: INP< Received 232 25-08-19 16:16:25.042.966 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.042.983 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.042.983 REC: INP> Begin r2552 l2552 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 2552] 25-08-19 16:16:25.043.010 REC: FE >Rebin in: N[2320 2551], #232 25-08-19 16:16:25.043.012 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 3572, 232] 25-08-19 16:16:25.043.631 ... RAW_DATA 25-08-19 16:16:25.056.187 REC: input=2552 internal=2552 balfront=2552 balready=2552 adaptready=2552 fusedready=2552 rebinfront=2552 output=1273 25-08-19 16:16:25.056.230 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.119.245 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 3572, 292.66, 292.81, CC] 25-08-19 16:16:25.119.335 REC: INP< Received 232 25-08-19 16:16:25.119.349 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.119.373 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.119.374 REC: INP> Begin r2784 l2784 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 2784] 25-08-19 16:16:25.119.390 REC: FE >Rebin in: N[2552 2783], #232 25-08-19 16:16:25.119.391 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 3804, 232] 25-08-19 16:16:25.119.986 ... RAW_DATA 25-08-19 16:16:25.132.463 REC: input=2784 internal=2784 balfront=2784 balready=2784 adaptready=2784 fusedready=2784 rebinfront=2784 output=1389 25-08-19 16:16:25.132.502 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.201.528 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 3804, 328.66, 328.81, CC] 25-08-19 16:16:25.201.555 REC: INP< Received 232 25-08-19 16:16:25.201.564 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.201.581 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.201.582 REC: INP> Begin r3016 l0 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 3016] 25-08-19 16:16:25.201.602 REC: FE >Rebin in: N[2784 3015], #232 25-08-19 16:16:25.201.659 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 4036, 232] 25-08-19 16:16:25.202.318 ... RAW_DATA 25-08-19 16:16:25.214.743 REC: input=3016 internal=3016 balfront=3016 balready=3016 adaptready=3016 fusedready=3016 rebinfront=3016 output=1505 25-08-19 16:16:25.214.781 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.271.330 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 4036, 4.66, 4.81, CC] 25-08-19 16:16:25.271.394 REC: INP< Received 232 25-08-19 16:16:25.271.406 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.271.421 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.271.424 REC: INP> Begin r3248 l232 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 3248] 25-08-19 16:16:25.271.436 REC: FE >Rebin in: N[3016 3247], #232 25-08-19 16:16:25.271.438 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 4268, 232] 25-08-19 16:16:25.272.089 ... RAW_DATA 25-08-19 16:16:25.284.474 REC: input=3248 internal=3248 balfront=3248 balready=3248 adaptready=3248 fusedready=3248 rebinfront=3248 output=1621 25-08-19 16:16:25.284.513 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.348.422 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 4268, 40.66, 40.81, CC] 25-08-19 16:16:25.348.452 REC: INP< Received 232 25-08-19 16:16:25.348.464 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.348.486 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.348.487 REC: INP> Begin r3480 l464 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 3480] 25-08-19 16:16:25.348.502 REC: FE >Rebin in: N[3248 3479], #232 25-08-19 16:16:25.348.502 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 4500, 232] 25-08-19 16:16:25.349.128 ... RAW_DATA 25-08-19 16:16:25.361.616 REC: input=3480 internal=3480 balfront=3480 balready=3480 adaptready=3480 fusedready=3480 rebinfront=3480 output=1737 25-08-19 16:16:25.361.657 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.425.823 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 4500, 76.66, 76.81, CC] 25-08-19 16:16:25.425.851 REC: INP< Received 232 25-08-19 16:16:25.425.895 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.425.908 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.425.914 REC: INP> Begin r3712 l696 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 3712] 25-08-19 16:16:25.425.925 REC: FE >Rebin in: N[3480 3711], #232 25-08-19 16:16:25.425.929 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 4732, 232] 25-08-19 16:16:25.426.532 ... RAW_DATA 25-08-19 16:16:25.438.966 REC: input=3712 internal=3712 balfront=3712 balready=3712 adaptready=3712 fusedready=3712 rebinfront=3712 output=1853 25-08-19 16:16:25.439.008 REC: FE Combine on P[162 1852] (1691), sinugram 0 25-08-19 16:16:25.485.529 REC: FE ----- ----- 25-08-19 16:16:25.485.565 REC: ----- DATA ----- 25-08-19 16:16:25.485.729 REC: ----- back_project (sinugram 0, ima 0)->(imabuf 0) 25-08-19 16:16:25.496.230 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:25.496.327 ... RAW_EOT 25-08-19 16:16:25.496.521 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.496.592 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 4732, 112.66, 112.81, CC] 25-08-19 16:16:25.496.632 REC: INP< Received 232 25-08-19 16:16:25.496.644 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.496.662 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.496.664 REC: INP> Begin r3944 l928 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 3944] 25-08-19 16:16:25.496.681 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 4964, 232] 25-08-19 16:16:25.496.682 REC: FE >Rebin in: N[3712 3943], #232 25-08-19 16:16:25.497.366 ... RAW_DATA 25-08-19 16:16:25.512.081 REC: input=3944 internal=3944 balfront=3944 balready=3944 adaptready=3944 fusedready=3944 rebinfront=3944 output=1969 25-08-19 16:16:25.512.116 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.573.188 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 4964, 148.66, 148.81, CC] 25-08-19 16:16:25.573.218 REC: INP< Received 232 25-08-19 16:16:25.573.233 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.573.258 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.573.260 REC: INP> Begin r4176 l1160 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 4176] 25-08-19 16:16:25.573.277 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 5196, 232] 25-08-19 16:16:25.573.278 REC: FE >Rebin in: N[3944 4175], #232 25-08-19 16:16:25.574.103 ... RAW_DATA 25-08-19 16:16:25.584.781 REC: BE ----- 25-08-19 16:16:25.584.899 REC: ..... ..... ?DATA ..... 25-08-19 16:16:25.584.929 REC: ----- ----- ----- >DATA 25-08-19 16:16:25.584.992 REC: OUT> imabuf,ImaNum,UPN: 0, 0, 0 25-08-19 16:16:25.585.015 <-- REC_RFM_IMAGE(1) 25-08-19 16:16:25.585.045 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:16:25.585.287 ... IMAGE_HDR_RES 25-08-19 16:16:25.585.654 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:16:25.585.680 <++ IMAGE_START 25-08-19 16:16:25.594.455 <++ IMAGE 25-08-19 16:16:25.594.469 ... IMAGE_EOT 25-08-19 16:16:25.594.765 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.594.785 REC: OUT< sent 25-08-19 16:16:25.594.793 REC: ----- ----- ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.653.037 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 5196, 184.66, 184.81, CC] 25-08-19 16:16:25.653.092 REC: INP< Received 232 25-08-19 16:16:25.653.102 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.653.117 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.653.118 REC: INP> Begin r4408 l1392 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 4408] 25-08-19 16:16:25.653.133 REC: FE >Rebin in: N[4176 4407], #232 25-08-19 16:16:25.653.135 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 5428, 232] 25-08-19 16:16:25.653.763 ... RAW_DATA 25-08-19 16:16:25.666.142 REC: input=4408 internal=4408 balfront=4408 balready=4408 adaptready=4408 fusedready=4408 rebinfront=4408 output=2201 25-08-19 16:16:25.666.182 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.722.238 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 5428, 220.66, 220.81, CC] 25-08-19 16:16:25.722.277 REC: INP< Received 232 25-08-19 16:16:25.722.288 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.722.301 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.722.302 REC: INP> Begin r4640 l1624 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 4640] 25-08-19 16:16:25.722.320 REC: FE >Rebin in: N[4408 4639], #232 25-08-19 16:16:25.722.320 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 5660, 232] 25-08-19 16:16:25.722.963 ... RAW_DATA 25-08-19 16:16:25.735.450 REC: input=4640 internal=4640 balfront=4640 balready=4640 adaptready=4640 fusedready=4640 rebinfront=4640 output=2317 25-08-19 16:16:25.735.489 REC: FE List group 1 25-08-19 16:16:25.735.645 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.800.229 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 5660, 256.66, 256.81, CC] 25-08-19 16:16:25.800.255 REC: INP< Received 232 25-08-19 16:16:25.800.264 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.800.280 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.800.281 REC: INP> Begin r4872 l1856 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 4872] 25-08-19 16:16:25.800.296 REC: FE >Rebin in: N[4640 4871], #232 25-08-19 16:16:25.800.335 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 5892, 232] 25-08-19 16:16:25.800.934 ... RAW_DATA 25-08-19 16:16:25.813.360 REC: input=4872 internal=4872 balfront=4872 balready=4872 adaptready=4872 fusedready=4872 rebinfront=4872 output=2433 25-08-19 16:16:25.813.402 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.870.239 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 5892, 292.66, 292.81, CC] 25-08-19 16:16:25.870.304 REC: INP< Received 232 25-08-19 16:16:25.870.314 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.870.330 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.870.330 REC: INP> Begin r5104 l2088 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 5104] 25-08-19 16:16:25.870.345 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 6124, 232] 25-08-19 16:16:25.870.346 REC: FE >Rebin in: N[4872 5103], #232 25-08-19 16:16:25.870.957 ... RAW_DATA 25-08-19 16:16:25.883.355 REC: input=5104 internal=5104 balfront=5104 balready=5104 adaptready=5104 fusedready=5104 rebinfront=5104 output=2549 25-08-19 16:16:25.883.396 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:25.945.184 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 6124, 328.66, 328.81, CC] 25-08-19 16:16:25.945.215 REC: INP< Received 232 25-08-19 16:16:25.945.226 REC: DATA> ----- ----- ----- 25-08-19 16:16:25.945.245 REC: ----- >DATA ----- ----- 25-08-19 16:16:25.945.246 REC: INP> Begin r5336 l2320 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 5336] 25-08-19 16:16:25.945.263 REC: FE >Rebin in: N[5104 5335], #232 25-08-19 16:16:25.945.277 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 6356, 232] 25-08-19 16:16:25.945.869 ... RAW_DATA 25-08-19 16:16:25.958.356 REC: input=5336 internal=5336 balfront=5336 balready=5336 adaptready=5336 fusedready=5336 rebinfront=5336 output=2665 25-08-19 16:16:25.958.398 REC: FE Combine on P[936 2664] (1729), sinugram 1 25-08-19 16:16:25.999.864 REC: FE ----- ----- 25-08-19 16:16:25.999.900 REC: ----- DATA ----- 25-08-19 16:16:25.999.930 REC: BE >back_project (sinugram 1, ima 2)->(imabuf 1) 25-08-19 16:16:26.000.084 REC: FE SRCH.2.ABOVE (go up) 25-08-19 16:16:26.000.101 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:26.025.567 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 6356, 4.66, 4.81, CC] 25-08-19 16:16:26.025.600 REC: INP< Received 232 25-08-19 16:16:26.025.613 REC: DATA> ----- ----- ----- 25-08-19 16:16:26.025.630 REC: ----- >DATA ----- ----- 25-08-19 16:16:26.025.652 REC: INP> Begin r5568 l2552 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 5568] 25-08-19 16:16:26.025.657 REC: FE >Rebin in: N[5336 5567], #232 25-08-19 16:16:26.025.669 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 6588, 232] 25-08-19 16:16:26.026.333 ... RAW_DATA 25-08-19 16:16:26.040.772 REC: input=5568 internal=5568 balfront=5568 balready=5568 adaptready=5568 fusedready=5568 rebinfront=5568 output=2781 25-08-19 16:16:26.040.815 REC: FE ----- 25-08-19 16:16:26.092.256 REC: ..... ..... ?DATA ..... 25-08-19 16:16:26.092.353 REC: ----- ----- ----- >DATA 25-08-19 16:16:26.092.374 REC: OUT> imabuf,ImaNum,UPN: 1, 2, 0 25-08-19 16:16:26.092.393 <-- REC_RFM_IMAGE(3) 25-08-19 16:16:26.092.411 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:16:26.092.557 ... IMAGE_HDR_RES 25-08-19 16:16:26.092.918 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:16:26.092.951 <++ IMAGE_START 25-08-19 16:16:26.093.233 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:26.093.400 ... RAW_EOT 25-08-19 16:16:26.093.472 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:26.093.487 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 6588, 40.66, 40.81, CC] 25-08-19 16:16:26.093.536 REC: INP< Received 232 25-08-19 16:16:26.093.555 REC: DATA> ----- ----- ----- 25-08-19 16:16:26.093.581 REC: INP> Begin r5800 l2784 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 5800] 25-08-19 16:16:26.093.614 REC: ----- >DATA ----- ----- 25-08-19 16:16:26.093.662 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 6820, 232] 25-08-19 16:16:26.093.755 REC: FE >Rebin in: N[5568 5799], #232 25-08-19 16:16:26.094.342 ... RAW_DATA 25-08-19 16:16:26.101.906 <++ IMAGE 25-08-19 16:16:26.101.942 ... IMAGE_EOT 25-08-19 16:16:26.102.225 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:16:26.102.249 REC: OUT< sent 25-08-19 16:16:26.102.262 REC: ----- ----- ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:26.168.927 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 6820, 76.66, 76.81, CC] 25-08-19 16:16:26.168.995 REC: INP< Received 232 25-08-19 16:16:26.169.006 REC: DATA> ----- ----- ----- 25-08-19 16:16:26.169.023 REC: ----- >DATA ----- ----- 25-08-19 16:16:26.169.023 REC: INP> Begin r6032 l0 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 6032] 25-08-19 16:16:26.169.042 REC: FE >Rebin in: N[5800 6031], #232 25-08-19 16:16:26.169.045 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 7052, 232] 25-08-19 16:16:26.169.760 ... RAW_DATA 25-08-19 16:16:26.182.100 REC: input=6032 internal=6032 balfront=6032 balready=6032 adaptready=6032 fusedready=6032 rebinfront=6032 output=3013 25-08-19 16:16:26.182.142 REC: FE List group 2 25-08-19 16:16:26.182.363 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:26.251.944 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 7052, 112.66, 112.81, CC] 25-08-19 16:16:26.251.972 REC: INP< Received 232 25-08-19 16:16:26.251.980 REC: DATA> ----- ----- ----- 25-08-19 16:16:26.251.992 REC: ----- >DATA ----- ----- 25-08-19 16:16:26.251.996 REC: INP> Begin r6264 l232 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 6264] 25-08-19 16:16:26.252.010 REC: FE >Rebin in: N[6032 6263], #232 25-08-19 16:16:26.252.016 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 7284, 232] 25-08-19 16:16:26.252.619 ... RAW_DATA 25-08-19 16:16:26.265.242 REC: input=6264 internal=6264 balfront=6264 balready=6264 adaptready=6264 fusedready=6264 rebinfront=6264 output=3129 25-08-19 16:16:26.265.285 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.307.857 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 7284, 148.66, 148.81, CC] 25-08-19 16:16:31.307.883 REC: INP< Received 232 25-08-19 16:16:31.307.891 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.307.914 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.307.917 REC: INP> Begin r6496 l464 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 6496] 25-08-19 16:16:31.307.929 REC: FE >Rebin in: N[6264 6495], #232 25-08-19 16:16:31.307.931 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 7516, 232] 25-08-19 16:16:31.308.483 ... RAW_DATA 25-08-19 16:16:31.321.216 REC: input=6496 internal=6496 balfront=6496 balready=6496 adaptready=6496 fusedready=6496 rebinfront=6496 output=3245 25-08-19 16:16:31.321.256 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.343.021 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 7516, 184.66, 184.81, CC] 25-08-19 16:16:31.343.053 REC: INP< Received 232 25-08-19 16:16:31.343.065 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.343.080 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.343.082 REC: INP> Begin r6728 l696 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 6728] 25-08-19 16:16:31.343.109 REC: FE >Rebin in: N[6496 6727], #232 25-08-19 16:16:31.343.111 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 7748, 232] 25-08-19 16:16:31.343.714 ... RAW_DATA 25-08-19 16:16:31.357.851 REC: input=6728 internal=6728 balfront=6728 balready=6728 adaptready=6728 fusedready=6728 rebinfront=6728 output=3361 25-08-19 16:16:31.357.970 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.374.099 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 7748, 220.66, 220.81, CC] 25-08-19 16:16:31.374.126 REC: INP< Received 232 25-08-19 16:16:31.374.135 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.374.153 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.374.154 REC: INP> Begin r6960 l928 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 6960] 25-08-19 16:16:31.374.219 REC: FE >Rebin in: N[6728 6959], #232 25-08-19 16:16:31.374.223 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 7980, 232] 25-08-19 16:16:31.374.882 ... RAW_DATA 25-08-19 16:16:31.388.399 REC: input=6960 internal=6960 balfront=6960 balready=6960 adaptready=6960 fusedready=6960 rebinfront=6960 output=3477 25-08-19 16:16:31.388.438 REC: FE Combine on P[1709 3476] (1768), sinugram 2 25-08-19 16:16:31.421.044 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.421.301 ... RAW_EOT 25-08-19 16:16:31.421.488 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.421.502 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 7980, 256.66, 256.81, CC] 25-08-19 16:16:31.421.574 REC: INP< Received 232 25-08-19 16:16:31.421.586 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.421.598 REC: INP> Begin r7192 l1160 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 7192] 25-08-19 16:16:31.421.612 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 8212, 232] 25-08-19 16:16:31.427.177 ... RAW_DATA 25-08-19 16:16:31.438.129 REC: FE ----- ----- 25-08-19 16:16:31.438.164 REC: ----- DATA ----- 25-08-19 16:16:31.438.201 REC: BE >back_project (sinugram 2, ima 4)->(imabuf 0) 25-08-19 16:16:31.438.379 REC: FE SRCH.2.ABOVE (go up) 25-08-19 16:16:31.438.404 REC: ----- Rebin in: N[6960 7191], #232 25-08-19 16:16:31.458.022 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.458.345 ... RAW_EOT 25-08-19 16:16:31.458.513 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.458.541 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 8212, 292.66, 292.81, CC] 25-08-19 16:16:31.458.730 REC: INP< Received 232 25-08-19 16:16:31.458.758 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.458.797 REC: INP> Begin r7424 l1392 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 7424] 25-08-19 16:16:31.458.822 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 8444, 232] 25-08-19 16:16:31.459.724 ... RAW_DATA 25-08-19 16:16:31.462.526 REC: input=7192 internal=7192 balfront=7192 balready=7192 adaptready=7192 fusedready=7192 rebinfront=7192 output=3593 25-08-19 16:16:31.462.568 REC: FE Rebin in: N[7192 7423], #232 25-08-19 16:16:31.481.736 REC: input=7424 internal=7424 balfront=7424 balready=7424 adaptready=7424 fusedready=7424 rebinfront=7424 output=3709 25-08-19 16:16:31.481.792 REC: FE DATA ----- ----- 25-08-19 16:16:31.482.204 REC: ..... ?DATA ..... ..... {Rebin} 25-08-19 16:16:31.492.044 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.492.501 ... RAW_EOT 25-08-19 16:16:31.492.545 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.492.556 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 8444, 328.66, 328.81, CC] 25-08-19 16:16:31.492.624 REC: INP< Received 232 25-08-19 16:16:31.492.638 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.492.652 REC: INP> Begin r7656 l1624 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 7656] 25-08-19 16:16:31.492.659 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.492.672 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 8676, 232] 25-08-19 16:16:31.492.696 REC: FE >Rebin in: N[7424 7655], #232 25-08-19 16:16:31.493.287 ... RAW_DATA 25-08-19 16:16:31.510.907 REC: input=7656 internal=7656 balfront=7656 balready=7656 adaptready=7656 fusedready=7656 rebinfront=7656 output=3825 25-08-19 16:16:31.510.958 REC: FE List group 3 25-08-19 16:16:31.511.410 REC: ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.527.488 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 8676, 4.66, 4.81, CC] 25-08-19 16:16:31.527.520 REC: INP< Received 232 25-08-19 16:16:31.527.531 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.527.555 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.527.559 REC: INP> Begin r7888 l1856 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 7888] 25-08-19 16:16:31.527.578 REC: FE >Rebin in: N[7656 7887], #232 25-08-19 16:16:31.527.644 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 8908, 232] 25-08-19 16:16:31.528.497 ... RAW_DATA 25-08-19 16:16:31.533.548 REC: BE ----- 25-08-19 16:16:31.533.662 REC: ..... ..... ?DATA ..... 25-08-19 16:16:31.533.666 REC: ----- ----- ----- >DATA 25-08-19 16:16:31.533.710 REC: OUT> imabuf,ImaNum,UPN: 0, 4, 0 25-08-19 16:16:31.533.732 <-- REC_RFM_IMAGE(5) 25-08-19 16:16:31.533.758 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:16:31.533.940 ... IMAGE_HDR_RES 25-08-19 16:16:31.534.277 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:16:31.534.327 <++ IMAGE_START 25-08-19 16:16:31.543.395 <++ IMAGE 25-08-19 16:16:31.543.555 ... IMAGE_EOT 25-08-19 16:16:31.545.090 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.545.115 REC: OUT< sent 25-08-19 16:16:31.545.127 REC: ----- ----- ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.565.478 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 8908, 40.66, 40.81, CC] 25-08-19 16:16:31.565.504 REC: INP< Received 232 25-08-19 16:16:31.565.512 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.565.527 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.565.530 REC: INP> Begin r8120 l2088 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 8120] 25-08-19 16:16:31.565.547 REC: FE >Rebin in: N[7888 8119], #232 25-08-19 16:16:31.565.589 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 9140, 232] 25-08-19 16:16:31.566.495 ... RAW_DATA 25-08-19 16:16:31.578.669 REC: input=8120 internal=8120 balfront=8120 balready=8120 adaptready=8120 fusedready=8120 rebinfront=8120 output=4057 25-08-19 16:16:31.578.714 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.605.680 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 9140, 76.66, 76.81, CC] 25-08-19 16:16:31.605.707 REC: INP< Received 232 25-08-19 16:16:31.605.715 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.605.729 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.605.737 REC: INP> Begin r8352 l2320 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 8352] 25-08-19 16:16:31.605.750 REC: FE >Rebin in: N[8120 8351], #232 25-08-19 16:16:31.605.753 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 9372, 232] 25-08-19 16:16:31.606.486 ... RAW_DATA 25-08-19 16:16:31.620.268 REC: input=8352 internal=8352 balfront=8352 balready=8352 adaptready=8352 fusedready=8352 rebinfront=8352 output=4173 25-08-19 16:16:31.620.309 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.637.635 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 9372, 112.66, 112.81, CC] 25-08-19 16:16:31.637.663 REC: INP< Received 232 25-08-19 16:16:31.637.677 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.637.690 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.637.694 REC: INP> Begin r8584 l2552 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 8584] 25-08-19 16:16:31.637.708 REC: FE >Rebin in: N[8352 8583], #232 25-08-19 16:16:31.637.775 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 9604, 232] 25-08-19 16:16:31.638.354 ... RAW_DATA 25-08-19 16:16:31.652.218 REC: input=8584 internal=8584 balfront=8584 balready=8584 adaptready=8584 fusedready=8584 rebinfront=8584 output=4289 25-08-19 16:16:31.652.287 REC: FE Combine on P[2485 4288] (1804), sinugram 3 25-08-19 16:16:31.672.058 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.672.269 ... RAW_EOT 25-08-19 16:16:31.672.389 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.672.410 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 9604, 148.66, 148.81, CC] 25-08-19 16:16:31.672.456 REC: INP< Received 232 25-08-19 16:16:31.672.467 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.672.481 REC: INP> Begin r8816 l2784 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 8816] 25-08-19 16:16:31.672.523 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 9836, 232] 25-08-19 16:16:31.672.996 ... RAW_DATA 25-08-19 16:16:31.706.127 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.706.289 ... RAW_EOT 25-08-19 16:16:31.706.510 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.706.569 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 9836, 184.66, 184.81, CC] 25-08-19 16:16:31.706.610 REC: INP< Received 232 25-08-19 16:16:31.706.622 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.706.634 REC: INP> Begin r9048 l0 Enquires 232 of 464 [Scan 0, Start 1020, Rcvd 9048] 25-08-19 16:16:31.706.680 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 10068, 232] 25-08-19 16:16:31.707.275 ... RAW_DATA 25-08-19 16:16:31.710.624 REC: FE ----- ----- 25-08-19 16:16:31.710.661 REC: ----- DATA ----- 25-08-19 16:16:31.710.690 REC: BE >back_project (sinugram 3, ima 6)->(imabuf 1) 25-08-19 16:16:31.710.847 REC: FE SRCH.2.ABOVE (go up) 25-08-19 16:16:31.710.864 REC: ----- Rebin in: N[8584 8815], #232 25-08-19 16:16:31.729.692 REC: input=8816 internal=8816 balfront=8816 balready=8816 adaptready=8816 fusedready=8816 rebinfront=8816 output=4405 25-08-19 16:16:31.729.759 REC: FE Rebin in: N[8816 9047], #232 25-08-19 16:16:31.745.347 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.746.967 ... RAW_EOT 25-08-19 16:16:31.747.137 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.747.169 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 10068, 220.66, 220.81, CC] 25-08-19 16:16:31.747.246 REC: INP< Received 232 25-08-19 16:16:31.747.265 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.747.489 REC: INP> Begin r9280 l232 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 9280] 25-08-19 16:16:31.747.524 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 10300, 232] 25-08-19 16:16:31.748.515 ... RAW_DATA 25-08-19 16:16:31.752.474 REC: input=9048 internal=9048 balfront=9048 balready=9048 adaptready=9048 fusedready=9048 rebinfront=9048 output=4521 25-08-19 16:16:31.752.509 REC: FE Rebin in: N[9048 9279], #232 25-08-19 16:16:31.771.728 REC: input=9280 internal=9280 balfront=9280 balready=9280 adaptready=9280 fusedready=9280 rebinfront=9280 output=4637 25-08-19 16:16:31.771.798 REC: FE List group 4 25-08-19 16:16:31.772.144 REC: ----- DATA ----- ----- 25-08-19 16:16:31.772.536 REC: ..... ?DATA ..... ..... {Rebin} 25-08-19 16:16:31.781.686 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.781.975 ... RAW_EOT 25-08-19 16:16:31.782.469 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.782.479 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 10300, 256.66, 256.81, CC] 25-08-19 16:16:31.782.506 REC: INP< Received 232 25-08-19 16:16:31.782.515 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.782.530 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.782.533 REC: INP> Begin r9512 l464 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 9512] 25-08-19 16:16:31.782.587 REC: FE >Rebin in: N[9280 9511], #232 25-08-19 16:16:31.782.589 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 10532, 232] 25-08-19 16:16:31.786.501 ... RAW_DATA 25-08-19 16:16:31.800.199 REC: input=9512 internal=9512 balfront=9512 balready=9512 adaptready=9512 fusedready=9512 rebinfront=9512 output=4753 25-08-19 16:16:31.800.250 REC: FE ----- 25-08-19 16:16:31.804.036 REC: ..... ..... ?DATA ..... 25-08-19 16:16:31.804.037 REC: ----- ----- ----- >DATA 25-08-19 16:16:31.804.193 REC: OUT> imabuf,ImaNum,UPN: 1, 6, 0 25-08-19 16:16:31.804.204 <-- REC_RFM_IMAGE(7) 25-08-19 16:16:31.804.219 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:16:31.804.532 ... IMAGE_HDR_RES 25-08-19 16:16:31.804.835 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:16:31.804.960 <++ IMAGE_START 25-08-19 16:16:31.813.842 <++ IMAGE 25-08-19 16:16:31.813.875 ... IMAGE_EOT 25-08-19 16:16:31.814.163 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.814.262 REC: OUT< sent 25-08-19 16:16:31.814.274 REC: ----- ----- ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.817.680 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 10532, 292.66, 292.81, CC] 25-08-19 16:16:31.817.715 REC: INP< Received 232 25-08-19 16:16:31.817.724 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.817.739 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.817.742 REC: INP> Begin r9744 l696 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 9744] 25-08-19 16:16:31.817.756 REC: FE >Rebin in: N[9512 9743], #232 25-08-19 16:16:31.817.795 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 10764, 232] 25-08-19 16:16:31.818.665 ... RAW_DATA 25-08-19 16:16:31.831.931 REC: input=9744 internal=9744 balfront=9744 balready=9744 adaptready=9744 fusedready=9744 rebinfront=9744 output=4869 25-08-19 16:16:31.831.972 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.853.879 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 10764, 328.66, 328.81, CC] 25-08-19 16:16:31.853.905 REC: INP< Received 232 25-08-19 16:16:31.853.914 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.853.929 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.853.932 REC: INP> Begin r9976 l928 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 9976] 25-08-19 16:16:31.853.947 REC: FE >Rebin in: N[9744 9975], #232 25-08-19 16:16:31.853.988 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 10996, 232] 25-08-19 16:16:31.854.688 ... RAW_DATA 25-08-19 16:16:31.868.315 REC: input=9976 internal=9976 balfront=9976 balready=9976 adaptready=9976 fusedready=9976 rebinfront=9976 output=4985 25-08-19 16:16:31.868.354 REC: FE Combine on P[3257 4984] (1728), sinugram 0 25-08-19 16:16:31.889.923 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.890.086 ... RAW_EOT 25-08-19 16:16:31.890.311 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.890.334 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 10996, 4.66, 4.81, CC] 25-08-19 16:16:31.890.369 REC: INP< Received 232 25-08-19 16:16:31.890.378 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.890.396 REC: INP> Begin r10208 l1160 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 10208] 25-08-19 16:16:31.890.450 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 11228, 232] 25-08-19 16:16:31.890.880 ... RAW_DATA 25-08-19 16:16:31.925.329 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.925.498 ... RAW_EOT 25-08-19 16:16:31.925.708 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.925.727 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 11228, 40.66, 40.81, CC] 25-08-19 16:16:31.925.788 REC: INP< Received 232 25-08-19 16:16:31.925.800 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.925.814 REC: INP> Begin r10440 l1392 Enquires 232 of 464 [Scan 0, Start 1020, Rcvd 10440] 25-08-19 16:16:31.925.830 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 11460, 232] 25-08-19 16:16:31.926.497 ... RAW_DATA 25-08-19 16:16:31.926.940 REC: FE ----- ----- 25-08-19 16:16:31.926.978 REC: ----- DATA ----- 25-08-19 16:16:31.926.983 REC: FE Grp CONT, Descr[1].[Scan 0, Start 1020, Enq 10904, Rcvd 10440] 25-08-19 16:16:31.926.996 REC: BE >back_project (sinugram 0, ima 8)->(imabuf 0) 25-08-19 16:16:31.927.183 REC: FE SRCH.2.ABOVE (go up) 25-08-19 16:16:31.927.215 REC: ----- Rebin in: N[9976 10207], #232 25-08-19 16:16:31.945.264 REC: input=10208 internal=10208 balfront=10208 balready=10208 adaptready=10208 fusedready=10208 rebinfront=10208 output=5101 25-08-19 16:16:31.945.318 REC: FE Rebin in: N[10208 10439], #232 25-08-19 16:16:31.965.874 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.966.256 ... RAW_EOT 25-08-19 16:16:31.966.401 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.966.507 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 11460, 76.66, 76.81, CC] 25-08-19 16:16:31.966.577 REC: INP< Received 232 25-08-19 16:16:31.966.596 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.966.630 REC: INP> Begin r10672 l1624 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 10672] 25-08-19 16:16:31.966.654 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 11692, 232] 25-08-19 16:16:31.967.398 ... RAW_DATA 25-08-19 16:16:31.969.401 REC: input=10440 internal=10440 balfront=10440 balready=10440 adaptready=10440 fusedready=10440 rebinfront=10440 output=5217 25-08-19 16:16:31.969.445 REC: FE Rebin in: N[10440 10671], #232 25-08-19 16:16:31.988.139 REC: input=10672 internal=10672 balfront=10672 balready=10672 adaptready=10672 fusedready=10672 rebinfront=10672 output=5333 25-08-19 16:16:31.988.180 REC: FE DATA ----- ----- 25-08-19 16:16:31.988.569 REC: ..... ?DATA ..... ..... {Rebin} 25-08-19 16:16:31.998.059 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:31.998.140 ... RAW_EOT 25-08-19 16:16:31.998.244 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:31.998.254 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 11692, 112.66, 112.81, CC] 25-08-19 16:16:31.998.344 REC: INP< Received 232 25-08-19 16:16:31.998.356 REC: DATA> ----- ----- ----- 25-08-19 16:16:31.998.373 REC: ----- >DATA ----- ----- 25-08-19 16:16:31.998.375 REC: INP> Begin r10904 l1856 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 10904] 25-08-19 16:16:31.998.391 REC: FE >Rebin in: N[10672 10903], #232 25-08-19 16:16:31.998.392 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 11924, 232] 25-08-19 16:16:31.999.000 ... RAW_DATA 25-08-19 16:16:32.015.713 REC: input=10904 internal=10904 balfront=10904 balready=10904 adaptready=10904 fusedready=10904 rebinfront=10904 output=5449 25-08-19 16:16:32.015.811 REC: FE List group 5 25-08-19 16:16:32.016.072 REC: ----- ----- 25-08-19 16:16:32.022.844 REC: ..... ..... ?DATA ..... 25-08-19 16:16:32.022.933 REC: ----- ----- ----- >DATA 25-08-19 16:16:32.022.949 REC: OUT> imabuf,ImaNum,UPN: 0, 8, 0 25-08-19 16:16:32.023.011 <-- REC_RFM_IMAGE(9) 25-08-19 16:16:32.023.184 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:16:32.023.548 ... IMAGE_HDR_RES 25-08-19 16:16:32.023.741 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:16:32.023.753 <++ IMAGE_START 25-08-19 16:16:32.033.318 <++ IMAGE 25-08-19 16:16:32.033.358 ... IMAGE_EOT 25-08-19 16:16:32.033.361 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:32.033.477 ... RAW_EOT 25-08-19 16:16:32.033.588 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.033.647 REC: OUT< sent 25-08-19 16:16:32.033.657 REC: ----- ----- ----- RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.033.730 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 11924, 148.66, 148.81, CC] 25-08-19 16:16:32.033.758 REC: INP< Received 232 25-08-19 16:16:32.033.768 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.033.782 REC: ----- >DATA ----- ----- 25-08-19 16:16:32.033.785 REC: INP> Begin r11136 l2088 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 11136] 25-08-19 16:16:32.033.803 REC: FE >Rebin in: N[10904 11135], #232 25-08-19 16:16:32.033.809 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 12156, 232] 25-08-19 16:16:32.034.441 ... RAW_DATA 25-08-19 16:16:32.048.628 REC: input=11136 internal=11136 balfront=11136 balready=11136 adaptready=11136 fusedready=11136 rebinfront=11136 output=5565 25-08-19 16:16:32.048.667 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.068.336 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 12156, 184.66, 184.81, CC] 25-08-19 16:16:32.068.362 REC: INP< Received 232 25-08-19 16:16:32.068.370 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.068.390 REC: ----- >DATA ----- ----- 25-08-19 16:16:32.068.393 REC: INP> Begin r11368 l2320 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 11368] 25-08-19 16:16:32.068.445 REC: FE >Rebin in: N[11136 11367], #232 25-08-19 16:16:32.068.447 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 12388, 232] 25-08-19 16:16:32.069.097 ... RAW_DATA 25-08-19 16:16:32.083.029 REC: input=11368 internal=11368 balfront=11368 balready=11368 adaptready=11368 fusedready=11368 rebinfront=11368 output=5681 25-08-19 16:16:32.083.072 REC: FE RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.106.733 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 12388, 220.66, 220.81, CC] 25-08-19 16:16:32.106.760 REC: INP< Received 232 25-08-19 16:16:32.106.767 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.106.785 REC: ----- >DATA ----- ----- 25-08-19 16:16:32.106.787 REC: INP> Begin r11600 l2552 Enquires 232 of 928 [Scan 0, Start 1020, Rcvd 11600] 25-08-19 16:16:32.106.800 REC: FE >Rebin in: N[11368 11599], #232 25-08-19 16:16:32.106.839 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 12620, 232] 25-08-19 16:16:32.107.455 ... RAW_DATA 25-08-19 16:16:32.120.099 REC: input=11600 internal=11600 balfront=11600 balready=11600 adaptready=11600 fusedready=11600 rebinfront=11600 output=5797 25-08-19 16:16:32.120.144 REC: FE Combine on P[4032 5796] (1765), sinugram 1 25-08-19 16:16:32.142.777 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:32.142.935 ... RAW_EOT 25-08-19 16:16:32.143.194 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.143.214 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 12620, 256.66, 256.81, CC] 25-08-19 16:16:32.143.250 REC: INP< Received 232 25-08-19 16:16:32.143.263 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.143.335 REC: INP> Begin r11832 l2784 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 11832] 25-08-19 16:16:32.143.353 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 12852, 232] 25-08-19 16:16:32.143.773 ... RAW_DATA 25-08-19 16:16:32.178.238 REC: FE ----- ----- 25-08-19 16:16:32.178.311 REC: ----- ----- >DATA ----- 25-08-19 16:16:32.178.353 REC: ----- back_project (sinugram 1, ima 10)->(imabuf 1) 25-08-19 16:16:32.178.386 REC: FE Grp CONT, Descr[1].[Scan 0, Start 1020, Enq 12528, Rcvd 11832] 25-08-19 16:16:32.178.416 ... RAW_EOT 25-08-19 16:16:32.178.577 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.178.668 REC: FE SRCH.2.ABOVE (go up) 25-08-19 16:16:32.178.687 REC: ----- RAW_DATA{1} [IRS_REQ_PENDING, 232, 12852, 292.66, 292.81, CC] 25-08-19 16:16:32.178.697 REC: INP< Received 232 25-08-19 16:16:32.178.694 REC: FE Grp CONT, Descr[1].[Scan 0, Start 1020, Enq 12760, Rcvd 11832] 25-08-19 16:16:32.178.707 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.178.721 REC: FE >Rebin in: N[11600 11831], #232 25-08-19 16:16:32.178.727 REC: INP> Begin r12064 l0 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 12064] 25-08-19 16:16:32.178.779 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 13084, 232] 25-08-19 16:16:32.179.277 ... RAW_DATA 25-08-19 16:16:32.202.914 REC: input=11832 internal=11832 balfront=11832 balready=11832 adaptready=11832 fusedready=11832 rebinfront=11832 output=5913 25-08-19 16:16:32.202.998 REC: FE Rebin in: N[11832 12063], #232 25-08-19 16:16:32.211.328 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:32.211.452 ... RAW_EOT 25-08-19 16:16:32.211.622 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.211.748 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 13084, 328.66, 328.81, CC] 25-08-19 16:16:32.211.789 REC: INP< Received 232 25-08-19 16:16:32.211.800 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.211.818 REC: INP> Begin r12296 l232 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 12296] 25-08-19 16:16:32.211.843 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 13316, 232] 25-08-19 16:16:32.212.289 ... RAW_DATA 25-08-19 16:16:32.226.593 REC: input=12064 internal=12064 balfront=12064 balready=12064 adaptready=12064 fusedready=12064 rebinfront=12064 output=6029 25-08-19 16:16:32.226.668 REC: FE Rebin in: N[12064 12295], #232 25-08-19 16:16:32.246.023 <++ RAW_RESP [IRS_REQ_PENDING] 25-08-19 16:16:32.246.215 ... RAW_EOT 25-08-19 16:16:32.250.775 ++> RAW_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.250.793 ++> RAW_DATA{1} [IRS_REQ_PENDING, 232, 13316, 4.66, 4.81, CC] 25-08-19 16:16:32.250.834 REC: INP< Received 232 25-08-19 16:16:32.250.845 REC: DATA> ----- ----- ----- 25-08-19 16:16:32.250.863 REC: INP> Begin r12528 l464 Enquires 232 of 696 [Scan 0, Start 1020, Rcvd 12528] 25-08-19 16:16:32.250.880 <++ RAW_REQ{1} [IRS_REQ_PENDING, 1, 13548, 232] 25-08-19 16:16:32.251.694 ... RAW_DATA 25-08-19 16:16:32.252.443 REC: input=12296 internal=12296 balfront=12296 balready=12296 adaptready=12296 fusedready=12296 rebinfront=12296 output=6145 25-08-19 16:16:32.252.491 REC: FE List group 6 25-08-19 16:16:32.252.722 REC: ----- Rebin in: N[12296 12527], #232 25-08-19 16:16:32.268.037 REC: input=12528 internal=12528 balfront=12528 balready=12528 adaptready=12528 fusedready=12528 rebinfront=12528 output=6261 25-08-19 16:16:32.268.184 REC: FE DATA ----- ----- 25-08-19 16:16:32.268.509 REC: ..... ?DATA ..... ..... {Rebin} 25-08-19 16:16:32.283.265 REC: BE ----- 25-08-19 16:16:32.283.401 REC: ..... ..... ?DATA ..... 25-08-19 16:16:32.283.436 REC: ----- ----- ----- >DATA 25-08-19 16:16:32.283.498 REC: OUT> imabuf,ImaNum,UPN: 1, 10, 0 25-08-19 16:16:32.283.524 <-- REC_RFM_IMAGE(11) 25-08-19 16:16:32.283.555 <++ IMAGE_HDR [IRS_REQ_PENDING] 25-08-19 16:16:32.283.803 ... IMAGE_HDR_RES 25-08-19 16:16:32.286.350 ++> IMAGE_HDR_RES [IRS_REQ_PENDING] 25-08-19 16:16:32.286.360 <++ IMAGE_START 25-08-19 16:16:32.293.678 <++ IMAGE 25-08-19 16:16:32.293.698 ... IMAGE_EOT 25-08-19 16:16:32.294.008 ++> IMAGE_EOT [IRS_REQ_PENDING] 25-08-19 16:16:32.294.064 REC: OUT< sent 25-08-19 16:16:32.294.074 REC: ----- ----- ----- ----- ----- ----- 25-08-19 16:16:35.286.226 <-- REC_DTH_DONE 25-08-19 16:16:35.286.239 REC: ----- ----- >BRK< ----- 25-08-19 16:16:35.286.244 REC: ----- >BRK< ----- ----- 25-08-19 16:16:35.286.253 <++ RAW_REQ{1} [IRS_REQ_DONE] 25-08-19 16:16:35.286.262 ->> XYZ_ABORT [CT_ITH_HW_NET_GBIT_REC1_DTH] 25-08-19 16:16:35.286.272 REC: ----- ----- ----- >BRK< 25-08-19 16:16:35.286.334 <-- DIS_ABORT [CT_ITH_HW_NET_GBIT_REC1_DTH, IRS_RESET_DEMANDED] 25-08-19 16:16:35.286.341 <-- REC_RFM_CANCELLED 25-08-19 16:16:35.286.306 REC: ----- ----- ----- 25-08-19 16:16:35.286.537 NET: IRSCMD_DIS_ABORT sent to IRSTCR(192.168.211.185)[(9100)-S] 25-08-19 16:16:35.299.846 NET: IRSCMD_DIS_LOG sent to IRSTCR(192.168.211.185)[(9100)-S] 25-08-19 16:16:37.372.600 NET: IRSCMD_DIS_EXIT received from IRSTCR(192.168.211.185)[(9100)-S] (data=12 B) 25-08-19 16:16:37.520.167 --> DIS_EXIT [IRS_EXIT_REBOOT] 25-08-19 16:16:37.520.181 REC: SHUTDOWN 25-08-19 16:16:37.520.211 ++> DONE_ACK(1) 25-08-19 16:16:37.520.242 Raw data receiving error: The operation was canceled by the user. 25-08-19 16:16:37.520.252 REC: ----- ----- ----- 25-08-19 16:16:37.520.707 REC: COMPLETE 25-08-19 16:16:37.521.964 REC: STOP 25-08-19 16:16:37.521.979 IRS: Exit: IRS_EXIT_REBOOT