2022-12-16 11:05:19,169 Start to Open the MARK_01 SECS Port
2022-12-16 11:05:19,169 SECSwell Version:4.0.1.17
2022-12-16 11:05:19,867 Start S9FxMonitor Thread.
2022-12-16 11:05:19,870 S9FxMonitor Thread Status = True
2022-12-16 11:05:19,870 HSMSPort::Initialize execute.
2022-12-16 11:05:19,872 Start - Connector Thread.
2022-12-16 11:05:19,875 - Connector Thread Status = True
2022-12-16 11:05:19,877 Start MARK_01#Parser Thread.
2022-12-16 11:05:19,909 MARK_01#Parser Thread Status = True
2022-12-16 11:05:19,914 Start MARK_01#Timer Thread.
2022-12-16 11:05:19,915 Completely Open the MARK_01 SECS Port
2022-12-16 11:05:19,915 HSMSPort::OnConnected Status=-4
2022-12-16 11:05:19,916 MARK_01#Timer Thread Status = True
2022-12-16 11:05:19,918 UpdateStatus: Prev:-3=>Now:-4=>New:0
2022-12-16 11:05:19,919 UpdateStatus: Prev:-4=>Now:0
2022-12-16 11:05:19,921 Start MARK_01#Reader Thread.
2022-12-16 11:05:19,924 MARK_01#Reader Thread Status = True
2022-12-16 11:05:19,926 Start MARK_01#Writer Thread.
2022-12-16 11:05:19,929 MARK_01#Writer Thread Status = True
2022-12-16 11:05:19,929 Timer::StartTimer -100
2022-12-16 11:05:19,930 Timer::StartTimer -6
2022-12-16 11:05:19,939 [WRITE] [SB:2130706432, 1] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00 
2022-12-16 11:05:19,940 [SEND] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00   Select.Req
2022-12-16 11:05:19,961 Timer::StartTimer -8
2022-12-16 11:05:19,962 Timer::StopTimer -8
2022-12-16 11:05:19,962 Read Data: 10 -- FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:05:19,963 Reader#ByteToBlock Header: FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:05:19,963 HSMSPort::OnReadHsms control message.
2022-12-16 11:05:19,963 Timer::StopTimer -6
2022-12-16 11:05:19,964 [RECV] FF FF 00 00 00 02 7F 00 00 00   Select.Rsp
2022-12-16 11:05:19,964 UpdateStatus: Prev:-4=>Now:0=>New:1
2022-12-16 11:05:19,964 UpdateStatus: Prev:0=>Now:1
2022-12-16 11:05:19,998 Writer#Run Send Primary Message 1
2022-12-16 11:05:20,003 Timer::StartT3Timer, SystemBytes=1
2022-12-16 11:05:20,003 WriteSendMessage: StartT3Timer 1
2022-12-16 11:05:20,003 [SEND] S1F13 W SystemBytes=1
00 00 00 0C 00 00 81 0D 00 00 00 00 00 01 01 00 
2022-12-16 11:05:20,003 [SEND] S1F13 W System Bytes=1
<L [0]
>
.

2022-12-16 11:05:20,102 Timer::StartTimer -8
2022-12-16 11:05:20,102 Timer::StopTimer -8
2022-12-16 11:05:20,102 Read Data: 33 -- 00 00 01 0E 00 00 00 00 00 01 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:05:20,102 Reader#ByteToBlock Header: 00 00 01 0E 00 00 00 00 00 01 
2022-12-16 11:05:20,102 Reader#ByteToBlock Data: 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:05:20,102 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:20,119 [RECV] S1F14  System Bytes=1 
2022-12-16 11:05:20,123 [RECV] S1F14 System Bytes=1
<L [2]
    <B [1] [COMMACK] '' 00  >
    <L [2]
        <A [6] []  '      ' >
        <A [6] []  '      ' >
    >
>
.

2022-12-16 11:05:20,124 Timer::StopT3Timer, SystemBytes=1
2022-12-16 11:05:20,657 Writer#Run Send Primary Message 2
2022-12-16 11:05:20,657 Timer::StartT3Timer, SystemBytes=2
2022-12-16 11:05:20,657 WriteSendMessage: StartT3Timer 2
2022-12-16 11:05:20,657 [SEND] S1F17 W SystemBytes=2
00 00 00 0A 00 00 81 11 00 00 00 00 00 02 
2022-12-16 11:05:20,657 [SEND] S1F17 W System Bytes=2

2022-12-16 11:05:20,748 Timer::StartTimer -8
2022-12-16 11:05:20,748 Timer::StopTimer -8
2022-12-16 11:05:20,748 Read Data: 13 -- 00 00 01 12 00 00 00 00 00 02 21 01 00 
2022-12-16 11:05:20,748 Reader#ByteToBlock Header: 00 00 01 12 00 00 00 00 00 02 
2022-12-16 11:05:20,748 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:05:20,748 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:20,763 [RECV] S1F18  System Bytes=2 
2022-12-16 11:05:20,763 [RECV] S1F18 System Bytes=2
<B [1] [] '' 00  >
.

2022-12-16 11:05:20,763 Timer::StopT3Timer, SystemBytes=2
2022-12-16 11:05:21,286 Writer#Run Send Primary Message 3
2022-12-16 11:05:21,286 Timer::StartT3Timer, SystemBytes=3
2022-12-16 11:05:21,286 WriteSendMessage: StartT3Timer 3
2022-12-16 11:05:21,286 [SEND] S1F3 W SystemBytes=3
00 00 00 42 00 00 81 03 00 00 00 00 00 03 01 09 B1 04 00 00 4F 4C B1 04 00 00 51 54 B1 04 00 00 4F B0 B1 04 00 00 4F B1 B1 04 00 00 52 12 B1 04 00 00 52 13 B1 04 00 00 51 44 B1 04 00 00 51 40 B1 04 00 00 51 41 
2022-12-16 11:05:21,287 [SEND] S1F3 W System Bytes=3
<L [9]
    <U4 [1] [Clock]  20300 >
    <U4 [1] [CommunicationState]  20820 >
    <U4 [1] [CurrentControlState]  20400 >
    <U4 [1] [PreviousControlState]  20401 >
    <U4 [1] [CurrentEquipmentState]  21010 >
    <U4 [1] [PreviousEquipmentState]  21011 >
    <U4 [1] [SpoolingState]  20804 >
    <U4 [1] [SpoolCountActual]  20800 >
    <U4 [1] [SpoolCountTotal]  20801 >
>
.

2022-12-16 11:05:21,391 Timer::StartTimer -8
2022-12-16 11:05:21,391 Timer::StopTimer -8
2022-12-16 11:05:21,391 Read Data: 71 -- 00 00 01 04 00 00 00 00 00 03 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:05:21,391 Reader#ByteToBlock Header: 00 00 01 04 00 00 00 00 00 03 
2022-12-16 11:05:21,391 Reader#ByteToBlock Data: 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:05:21,391 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:21,406 [RECV] S1F4  System Bytes=3 
2022-12-16 11:05:21,407 [RECV] S1F4 System Bytes=3
<L [10]
    <A [19] [SVID]  '2021-09-17T13:48:25' >
    <U1 [1] []  0 >
    <U1 [1] []  4 >
    <U1 [1] []  5 >
    <U2 [1] []  2000 >
    <U2 [1] []  1000 >
    <A [4] []  'test' >
    <U1 [1] []  0 >
    <U4 [1] []  0 >
    <U4 [1] []  0 >
>
.

2022-12-16 11:05:21,407 Timer::StopT3Timer, SystemBytes=3
2022-12-16 11:05:21,930 Writer#Run Send Primary Message 4
2022-12-16 11:05:21,930 Timer::StartT3Timer, SystemBytes=4
2022-12-16 11:05:21,930 WriteSendMessage: StartT3Timer 4
2022-12-16 11:05:21,930 [SEND] S6F23 W SystemBytes=4
00 00 00 0D 00 00 86 17 00 00 00 00 00 04 A5 01 00 
2022-12-16 11:05:21,930 [SEND] S6F23 W System Bytes=4
<U1 [1] [RSDC]  0 >
.

2022-12-16 11:05:22,019 Timer::StartTimer -8
2022-12-16 11:05:22,019 Timer::StopTimer -8
2022-12-16 11:05:22,019 Read Data: 13 -- 00 00 06 18 00 00 00 00 00 04 21 01 01 
2022-12-16 11:05:22,019 Reader#ByteToBlock Header: 00 00 06 18 00 00 00 00 00 04 
2022-12-16 11:05:22,019 Reader#ByteToBlock Data: 21 01 01 
2022-12-16 11:05:22,019 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:22,034 [RECV] S6F24  System Bytes=4 
2022-12-16 11:05:22,034 [RECV] S6F24 System Bytes=4
<B [1] [] '' 01  >
.

2022-12-16 11:05:22,034 Timer::StopT3Timer, SystemBytes=4
2022-12-16 11:05:22,558 Writer#Run Send Primary Message 5
2022-12-16 11:05:22,558 Timer::StartT3Timer, SystemBytes=5
2022-12-16 11:05:22,558 WriteSendMessage: StartT3Timer 5
2022-12-16 11:05:22,558 [SEND] S2F43 W SystemBytes=5
00 00 00 0C 00 00 82 2B 00 00 00 00 00 05 01 00 
2022-12-16 11:05:22,558 [SEND] S2F43 W System Bytes=5
<L [0]
>
.

2022-12-16 11:05:22,678 Timer::StartTimer -8
2022-12-16 11:05:22,678 Timer::StopTimer -8
2022-12-16 11:05:22,678 Read Data: 17 -- 00 00 02 2C 00 00 00 00 00 05 01 02 21 01 00 01 00 
2022-12-16 11:05:22,678 Reader#ByteToBlock Header: 00 00 02 2C 00 00 00 00 00 05 
2022-12-16 11:05:22,678 Reader#ByteToBlock Data: 01 02 21 01 00 01 00 
2022-12-16 11:05:22,678 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:22,692 [RECV] S2F44  System Bytes=5 
2022-12-16 11:05:22,692 [RECV] S2F44 System Bytes=5
<L [2]
    <B [1] [] '' 00  >
    <L [0]
    >
>
.

2022-12-16 11:05:22,692 Timer::StopT3Timer, SystemBytes=5
2022-12-16 11:05:23,216 Writer#Run Send Primary Message 6
2022-12-16 11:05:23,216 Timer::StartT3Timer, SystemBytes=6
2022-12-16 11:05:23,216 WriteSendMessage: StartT3Timer 6
2022-12-16 11:05:23,216 [SEND] S2F37 W SystemBytes=6
00 00 00 11 00 00 82 25 00 00 00 00 00 06 01 02 25 01 00 01 00 
2022-12-16 11:05:23,216 [SEND] S2F37 W System Bytes=6
<L [2]
    <BOOLEAN [1] [CEED]  F >
    <L [0]
    >
>
.

2022-12-16 11:05:23,321 Timer::StartTimer -8
2022-12-16 11:05:23,321 Timer::StopTimer -8
2022-12-16 11:05:23,321 Read Data: 13 -- 00 00 02 26 00 00 00 00 00 06 21 01 00 
2022-12-16 11:05:23,321 Reader#ByteToBlock Header: 00 00 02 26 00 00 00 00 00 06 
2022-12-16 11:05:23,321 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:05:23,321 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:23,336 [RECV] S2F38  System Bytes=6 
2022-12-16 11:05:23,336 [RECV] S2F38 System Bytes=6
<B [1] [] '' 00  >
.

2022-12-16 11:05:23,336 Timer::StopT3Timer, SystemBytes=6
2022-12-16 11:05:23,859 Writer#Run Send Primary Message 7
2022-12-16 11:05:23,859 Timer::StartT3Timer, SystemBytes=7
2022-12-16 11:05:23,859 WriteSendMessage: StartT3Timer 7
2022-12-16 11:05:23,859 [SEND] S2F35 W SystemBytes=7
00 00 00 14 00 00 82 23 00 00 00 00 00 07 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:05:23,859 [SEND] S2F35 W System Bytes=7
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:05:23,964 Timer::StartTimer -8
2022-12-16 11:05:23,964 Timer::StopTimer -8
2022-12-16 11:05:23,964 Read Data: 13 -- 00 00 02 24 00 00 00 00 00 07 21 01 00 
2022-12-16 11:05:23,964 Reader#ByteToBlock Header: 00 00 02 24 00 00 00 00 00 07 
2022-12-16 11:05:23,964 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:05:23,964 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:23,979 [RECV] S2F36  System Bytes=7 
2022-12-16 11:05:23,979 [RECV] S2F36 System Bytes=7
<B [1] [] '' 00  >
.

2022-12-16 11:05:23,979 Timer::StopT3Timer, SystemBytes=7
2022-12-16 11:05:24,503 Writer#Run Send Primary Message 8
2022-12-16 11:05:24,503 Timer::StartT3Timer, SystemBytes=8
2022-12-16 11:05:24,503 WriteSendMessage: StartT3Timer 8
2022-12-16 11:05:24,503 [SEND] S2F33 W SystemBytes=8
00 00 00 14 00 00 82 21 00 00 00 00 00 08 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:05:24,503 [SEND] S2F33 W System Bytes=8
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:05:24,607 Timer::StartTimer -8
2022-12-16 11:05:24,607 Timer::StopTimer -8
2022-12-16 11:05:24,607 Read Data: 13 -- 00 00 02 22 00 00 00 00 00 08 21 01 00 
2022-12-16 11:05:24,607 Reader#ByteToBlock Header: 00 00 02 22 00 00 00 00 00 08 
2022-12-16 11:05:24,607 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:05:24,607 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:24,622 [RECV] S2F34  System Bytes=8 
2022-12-16 11:05:24,622 [RECV] S2F34 System Bytes=8
<B [1] [DRACK] '' 00  >
.

2022-12-16 11:05:24,622 Timer::StopT3Timer, SystemBytes=8
2022-12-16 11:05:25,146 Writer#Run Send Primary Message 9
2022-12-16 11:05:25,146 Timer::StartT3Timer, SystemBytes=9
2022-12-16 11:05:25,146 WriteSendMessage: StartT3Timer 9
2022-12-16 11:05:25,146 [SEND] S5F3 W SystemBytes=9
00 00 00 15 00 00 85 03 00 00 00 00 00 09 01 02 21 01 00 B1 04 00 00 00 00 
2022-12-16 11:05:25,146 [SEND] S5F3 W System Bytes=9
<L [2]
    <B [1] [ALED] '' 00  >
    <U4 [1] [ALID]  0 >
>
.

2022-12-16 11:05:25,251 Timer::StartTimer -8
2022-12-16 11:05:25,251 Timer::StopTimer -8
2022-12-16 11:05:25,251 Read Data: 13 -- 00 00 05 04 00 00 00 00 00 09 21 01 00 
2022-12-16 11:05:25,251 Reader#ByteToBlock Header: 00 00 05 04 00 00 00 00 00 09 
2022-12-16 11:05:25,251 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:05:25,251 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:05:25,266 [RECV] S5F4  System Bytes=9 
2022-12-16 11:05:25,266 [RECV] S5F4 System Bytes=9
<B [1] [ACKC5] '' 00  >
.

2022-12-16 11:05:25,266 Timer::StopT3Timer, SystemBytes=9
2022-12-16 11:05:25,804 Writer#Run Send Primary Message 10
2022-12-16 11:05:25,804 Timer::StartT3Timer, SystemBytes=10
2022-12-16 11:05:25,804 WriteSendMessage: StartT3Timer 10
2022-12-16 11:05:25,804 [SEND] S2F33 W SystemBytes=10
00 00 02 18 00 00 82 21 00 00 00 00 00 0A 01 02 B1 04 00 00 00 00 01 0F 01 02 B1 04 00 00 00 01 01 03 B1 04 00 00 4F 4C B1 04 00 00 4F B0 B1 04 00 00 4F B1 01 02 B1 04 00 00 00 0B 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 0C 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 15 01 03 B1 04 00 00 4F 4C B1 04 00 00 51 40 B1 04 00 00 51 44 01 02 B1 04 00 00 00 16 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 17 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 78 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 00 00 79 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 03 0D 4B 01 05 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 41 B1 04 00 00 9C 40 B1 04 00 00 9C 42 01 02 B1 04 00 03 0D 4C 01 0D B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 41 B1 04 00 00 9C 42 B1 04 00 00 9C 4A B1 04 00 00 9C 4B B1 04 00 00 9C 4C B1 04 00 00 9C 4D B1 04 00 00 9C 4E B1 04 00 00 9C 4F B1 04 00 00 9C 50 B1 04 00 00 9C 51 01 02 B1 04 00 03 0D 55 01 03 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 01 02 B1 04 00 03 0D 56 01 0B B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 42 B1 04 00 00 A0 28 B1 04 00 00 A0 2A B1 04 00 00 A0 2B B1 04 00 00 A0 2C B1 04 00 00 A0 2D B1 04 00 00 A0 2E B1 04 00 00 A0 2F 01 02 B1 04 00 03 0D 60 01 02 B1 04 00 00 4F 4C B1 04 00 00 65 90 01 02 B1 04 00 03 0D 69 01 04 B1 04 00 00 4F 4C B1 04 00 00 52 14 B1 04 00 00 52 15 B1 04 00 00 52 16 01 02 B1 04 00 03 0D 7D 01 03 B1 04 00 00 4F 4C B1 04 00 00 52 12 B1 04 00 00 52 13 
2022-12-16 11:05:25,804 [SEND] S2F33 W System Bytes=10
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [15]
        <L [2]
            <U4 [1] [reportid]  1 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentControlState]  20400 >
                <U4 [1] [PreviousControlState]  20401 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  11 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  12 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  21 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
                <U4 [1] [SpoolingState]  20804 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  22 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  23 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  120 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  121 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200011 >
            <L [5]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200012 >
            <L [13]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] [Target A]  40010 >
                <U4 [1] [Target B]  40011 >
                <U4 [1] [Target C]  40012 >
                <U4 [1] [Target D]  40013 >
                <U4 [1] [Reroute A]  40014 >
                <U4 [1] [Reroute B]  40015 >
                <U4 [1] [Reroute C]  40016 >
                <U4 [1] [Reroute D]  40017 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200021 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200022 >
            <L [11]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] []  41000 >
                <U4 [1] []  41002 >
                <U4 [1] []  41003 >
                <U4 [1] []  41004 >
                <U4 [1] []  41005 >
                <U4 [1] []  41006 >
                <U4 [1] []  41007 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200032 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SlotList]  26000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200041 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [UserName]  21012 >
                <U4 [1] [PreviousUserName]  21013 >
                <U4 [1] [LoginState]  21014 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200061 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentEquipmentState]  21010 >
                <U4 [1] [PreviousEquipmentState]  21011 >
            >
        >
    >
>
.

2022-12-16 11:06:11,083 HSMSTimer::CheckT3Timeout: 45.2787527, 10
2022-12-16 11:06:11,083 T3 Timeout: System Bytes=10
2022-12-16 11:06:11,083 Timer#Run: Timeout Message System Bytes=10
2022-12-16 11:06:11,090 SystemBytes: 10, ERRCODE: T3TimeOut, ERRDESC: T3 TimeOut: Reply Timeout..
2022-12-16 11:06:25,806 Timer::StartTimer -8
2022-12-16 11:06:25,806 Timer::StopTimer -8
2022-12-16 11:06:25,806 Read Data: 10 -- FF FF 00 00 00 05 38 29 53 0F 
2022-12-16 11:06:25,806 Reader#ByteToBlock Header: FF FF 00 00 00 05 38 29 53 0F 
2022-12-16 11:06:25,806 HSMSPort::OnReadHsms control message.
2022-12-16 11:06:25,806 [RECV] FF FF 00 00 00 05 38 29 53 0F   LinkTest.Req
2022-12-16 11:06:25,806 [WRITE] [SB:942232335, 6] 00 00 00 0A FF FF 00 00 00 06 38 29 53 0F 
2022-12-16 11:06:25,806 [SEND] 00 00 00 0A FF FF 00 00 00 06 38 29 53 0F   LinkTest.Rsp
2022-12-16 11:07:20,283 HSMSTimer::CheckOtherTimeout: 120.3557881, -100
2022-12-16 11:07:20,284 Timer::StartTimer -6
2022-12-16 11:07:20,284 [WRITE] [SB:2130706433, 5] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 01 
2022-12-16 11:07:20,284 [SEND] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 01   LinkTest.Req
2022-12-16 11:07:20,284 Timer::StartTimer -100
2022-12-16 11:07:20,299 Timer::StartTimer -8
2022-12-16 11:07:20,299 Timer::StopTimer -8
2022-12-16 11:07:20,299 Read Data: 10 -- FF FF 00 00 00 06 7F 00 00 01 
2022-12-16 11:07:20,299 Reader#ByteToBlock Header: FF FF 00 00 00 06 7F 00 00 01 
2022-12-16 11:07:20,299 HSMSPort::OnReadHsms control message.
2022-12-16 11:07:20,299 Timer::StopTimer -6
2022-12-16 11:07:20,300 [RECV] FF FF 00 00 00 06 7F 00 00 01   LinkTest.Rsp
2022-12-16 11:08:20,312 Timer::StartTimer -8
2022-12-16 11:08:20,312 Timer::StopTimer -8
2022-12-16 11:08:20,312 Read Data: 10 -- FF FF 00 00 00 05 38 29 53 10 
2022-12-16 11:08:20,312 Reader#ByteToBlock Header: FF FF 00 00 00 05 38 29 53 10 
2022-12-16 11:08:20,312 HSMSPort::OnReadHsms control message.
2022-12-16 11:08:20,312 [RECV] FF FF 00 00 00 05 38 29 53 10   LinkTest.Req
2022-12-16 11:08:20,312 [WRITE] [SB:942232336, 6] 00 00 00 0A FF FF 00 00 00 06 38 29 53 10 
2022-12-16 11:08:20,312 [SEND] 00 00 00 0A FF FF 00 00 00 06 38 29 53 10   LinkTest.Rsp
2022-12-16 11:09:20,324 Timer::StartTimer -8
2022-12-16 11:09:20,324 Timer::StopTimer -8
2022-12-16 11:09:20,324 Read Data: 10 -- FF FF 00 00 00 05 38 29 53 11 
2022-12-16 11:09:20,324 Reader#ByteToBlock Header: FF FF 00 00 00 05 38 29 53 11 
2022-12-16 11:09:20,324 HSMSPort::OnReadHsms control message.
2022-12-16 11:09:20,324 [RECV] FF FF 00 00 00 05 38 29 53 11   LinkTest.Req
2022-12-16 11:09:20,324 [WRITE] [SB:942232337, 6] 00 00 00 0A FF FF 00 00 00 06 38 29 53 11 
2022-12-16 11:09:20,325 [SEND] 00 00 00 0A FF FF 00 00 00 06 38 29 53 11   LinkTest.Rsp
2022-12-16 11:09:20,578 HSMSTimer::CheckOtherTimeout: 120.2942269, -100
2022-12-16 11:09:20,578 Timer::StartTimer -6
2022-12-16 11:09:20,578 [WRITE] [SB:2130706434, 5] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 02 
2022-12-16 11:09:20,578 [SEND] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 02   LinkTest.Req
2022-12-16 11:09:20,578 Timer::StartTimer -100
2022-12-16 11:09:20,594 Timer::StartTimer -8
2022-12-16 11:09:20,594 Timer::StopTimer -8
2022-12-16 11:09:20,594 Read Data: 10 -- FF FF 00 00 00 06 7F 00 00 02 
2022-12-16 11:09:20,594 Reader#ByteToBlock Header: FF FF 00 00 00 06 7F 00 00 02 
2022-12-16 11:09:20,594 HSMSPort::OnReadHsms control message.
2022-12-16 11:09:20,594 Timer::StopTimer -6
2022-12-16 11:09:20,594 [RECV] FF FF 00 00 00 06 7F 00 00 02   LinkTest.Rsp
2022-12-16 11:09:32,571 Start to Close the MARK_01 SECS Port
2022-12-16 11:09:32,571 UpdateStatus: Prev:0=>Now:1=>New:-2
2022-12-16 11:09:32,571 UpdateStatus: Prev:1=>Now:-2
2022-12-16 11:09:32,572 Terminate MARK_01#Reader Thread.
2022-12-16 11:09:32,572 [WRITE] [SB:2130706435, 9] 00 00 00 0A FF FF 00 00 00 09 7F 00 00 03 
2022-12-16 11:09:32,572 [SEND] 00 00 00 0A FF FF 00 00 00 09 7F 00 00 03   Separate.Req
2022-12-16 11:09:32,639 Terminate MARK_01#Parser Thread.
2022-12-16 11:09:32,639 Terminate - Connector Thread.
2022-12-16 11:09:32,639 Terminate MARK_01#Writer Thread.
2022-12-16 11:09:32,654 MARK_01#Writer Thread Status = False
2022-12-16 11:09:32,654 MARK_01#Parser Thread Status = False
2022-12-16 11:09:32,744 Terminate MARK_01#Timer Thread.
2022-12-16 11:09:32,744 Timer::StopTimer -100
2022-12-16 11:09:32,744 Timer::StopTimer -6
2022-12-16 11:09:32,745 HSMSPort::TerminateSocket execute.
2022-12-16 11:09:32,750 Reader#Run
System.ObjectDisposedException: 无法访问已释放的对象。
对象名:“System.Net.Sockets.NetworkStream”。
   在 System.Net.Sockets.NetworkStream.Read(Byte[] buffer, Int32 offset, Int32 size)
   在 System.IO.BinaryReader.Read(Byte[] buffer, Int32 index, Int32 count)
   在 CSch2tI1noUwdMbW1CT.bpXunUIHrU3XGjcvxIh.mEFIsTOntY(Byte[]  )
   在 CSch2tI1noUwdMbW1CT.bpXunUIHrU3XGjcvxIh.d6Bd3MvACv() 位置 D:\glorysoft\git.project\EAP.Products\sh-div-xfw-0811\XFW\SourceCode\Glorysoft.SECSwell.Fx\HSMS\HSMSWriter.cs:行号 38
2022-12-16 11:09:32,753 Terminate MARK_01#Reader Thread.
2022-12-16 11:09:32,753 Reader#FireDisconnect Invoked.
2022-12-16 11:09:32,753 MARK_01#Reader Thread Status = False
2022-12-16 11:09:32,849 Terminate S9FxMonitor Thread.
2022-12-16 11:09:32,849 Completely Close the MARK_01 SECS Port
2022-12-16 11:09:32,901 S9FxMonitor Thread Status = False
2022-12-16 11:09:55,703 Start to Open the MARK_01 SECS Port
2022-12-16 11:09:55,703 SECSwell Version:4.0.1.17
2022-12-16 11:09:56,344 Start S9FxMonitor Thread.
2022-12-16 11:09:56,346 S9FxMonitor Thread Status = True
2022-12-16 11:09:56,347 HSMSPort::Initialize execute.
2022-12-16 11:09:56,349 Start - Connector Thread.
2022-12-16 11:09:56,351 - Connector Thread Status = True
2022-12-16 11:09:56,352 Start MARK_01#Parser Thread.
2022-12-16 11:09:56,385 MARK_01#Parser Thread Status = True
2022-12-16 11:09:56,390 Start MARK_01#Timer Thread.
2022-12-16 11:09:56,390 Completely Open the MARK_01 SECS Port
2022-12-16 11:09:56,390 HSMSPort::OnConnected Status=-4
2022-12-16 11:09:56,392 MARK_01#Timer Thread Status = True
2022-12-16 11:09:56,393 UpdateStatus: Prev:-3=>Now:-4=>New:0
2022-12-16 11:09:56,395 UpdateStatus: Prev:-4=>Now:0
2022-12-16 11:09:56,396 Start MARK_01#Reader Thread.
2022-12-16 11:09:56,398 MARK_01#Reader Thread Status = True
2022-12-16 11:09:56,399 Start MARK_01#Writer Thread.
2022-12-16 11:09:56,403 MARK_01#Writer Thread Status = True
2022-12-16 11:09:56,404 Timer::StartTimer -100
2022-12-16 11:09:56,406 Timer::StartTimer -6
2022-12-16 11:09:56,416 [WRITE] [SB:2130706432, 1] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00 
2022-12-16 11:09:56,417 [SEND] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00   Select.Req
2022-12-16 11:09:56,431 Timer::StartTimer -8
2022-12-16 11:09:56,433 Timer::StopTimer -8
2022-12-16 11:09:56,433 Read Data: 10 -- FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:09:56,433 Reader#ByteToBlock Header: FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:09:56,434 HSMSPort::OnReadHsms control message.
2022-12-16 11:09:56,434 Timer::StopTimer -6
2022-12-16 11:09:56,434 [RECV] FF FF 00 00 00 02 7F 00 00 00   Select.Rsp
2022-12-16 11:09:56,434 UpdateStatus: Prev:-4=>Now:0=>New:1
2022-12-16 11:09:56,434 UpdateStatus: Prev:0=>Now:1
2022-12-16 11:09:56,474 Writer#Run Send Primary Message 1
2022-12-16 11:09:56,479 Timer::StartT3Timer, SystemBytes=1
2022-12-16 11:09:56,479 WriteSendMessage: StartT3Timer 1
2022-12-16 11:09:56,479 [SEND] S1F13 W SystemBytes=1
00 00 00 0C 00 00 81 0D 00 00 00 00 00 01 01 00 
2022-12-16 11:09:56,479 [SEND] S1F13 W System Bytes=1
<L [0]
>
.

2022-12-16 11:09:56,563 Timer::StartTimer -8
2022-12-16 11:09:56,563 Timer::StopTimer -8
2022-12-16 11:09:56,563 Read Data: 33 -- 00 00 01 0E 00 00 00 00 00 01 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:09:56,563 Reader#ByteToBlock Header: 00 00 01 0E 00 00 00 00 00 01 
2022-12-16 11:09:56,563 Reader#ByteToBlock Data: 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:09:56,563 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:09:56,580 [RECV] S1F14  System Bytes=1 
2022-12-16 11:09:56,584 [RECV] S1F14 System Bytes=1
<L [2]
    <B [1] [COMMACK] '' 00  >
    <L [2]
        <A [6] []  '      ' >
        <A [6] []  '      ' >
    >
>
.

2022-12-16 11:09:56,585 Timer::StopT3Timer, SystemBytes=1
2022-12-16 11:09:57,117 Writer#Run Send Primary Message 2
2022-12-16 11:09:57,117 Timer::StartT3Timer, SystemBytes=2
2022-12-16 11:09:57,117 WriteSendMessage: StartT3Timer 2
2022-12-16 11:09:57,117 [SEND] S1F17 W SystemBytes=2
00 00 00 0A 00 00 81 11 00 00 00 00 00 02 
2022-12-16 11:09:57,117 [SEND] S1F17 W System Bytes=2

2022-12-16 11:09:57,207 Timer::StartTimer -8
2022-12-16 11:09:57,207 Timer::StopTimer -8
2022-12-16 11:09:57,207 Read Data: 13 -- 00 00 01 12 00 00 00 00 00 02 21 01 00 
2022-12-16 11:09:57,207 Reader#ByteToBlock Header: 00 00 01 12 00 00 00 00 00 02 
2022-12-16 11:09:57,207 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:09:57,207 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:09:57,222 [RECV] S1F18  System Bytes=2 
2022-12-16 11:09:57,222 [RECV] S1F18 System Bytes=2
<B [1] [] '' 00  >
.

2022-12-16 11:09:57,222 Timer::StopT3Timer, SystemBytes=2
2022-12-16 11:09:57,745 Writer#Run Send Primary Message 3
2022-12-16 11:09:57,745 Timer::StartT3Timer, SystemBytes=3
2022-12-16 11:09:57,745 WriteSendMessage: StartT3Timer 3
2022-12-16 11:09:57,745 [SEND] S1F3 W SystemBytes=3
00 00 00 42 00 00 81 03 00 00 00 00 00 03 01 09 B1 04 00 00 4F 4C B1 04 00 00 51 54 B1 04 00 00 4F B0 B1 04 00 00 4F B1 B1 04 00 00 52 12 B1 04 00 00 52 13 B1 04 00 00 51 44 B1 04 00 00 51 40 B1 04 00 00 51 41 
2022-12-16 11:09:57,745 [SEND] S1F3 W System Bytes=3
<L [9]
    <U4 [1] [Clock]  20300 >
    <U4 [1] [CommunicationState]  20820 >
    <U4 [1] [CurrentControlState]  20400 >
    <U4 [1] [PreviousControlState]  20401 >
    <U4 [1] [CurrentEquipmentState]  21010 >
    <U4 [1] [PreviousEquipmentState]  21011 >
    <U4 [1] [SpoolingState]  20804 >
    <U4 [1] [SpoolCountActual]  20800 >
    <U4 [1] [SpoolCountTotal]  20801 >
>
.

2022-12-16 11:09:57,865 Timer::StartTimer -8
2022-12-16 11:09:57,865 Timer::StopTimer -8
2022-12-16 11:09:57,865 Read Data: 71 -- 00 00 01 04 00 00 00 00 00 03 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:09:57,865 Reader#ByteToBlock Header: 00 00 01 04 00 00 00 00 00 03 
2022-12-16 11:09:57,865 Reader#ByteToBlock Data: 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:09:57,865 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:09:57,880 [RECV] S1F4  System Bytes=3 
2022-12-16 11:09:57,881 [RECV] S1F4 System Bytes=3
<L [10]
    <A [19] [SVID]  '2021-09-17T13:48:25' >
    <U1 [1] []  0 >
    <U1 [1] []  4 >
    <U1 [1] []  5 >
    <U2 [1] []  2000 >
    <U2 [1] []  1000 >
    <A [4] []  'test' >
    <U1 [1] []  0 >
    <U4 [1] []  0 >
    <U4 [1] []  0 >
>
.

2022-12-16 11:09:57,881 Timer::StopT3Timer, SystemBytes=3
2022-12-16 11:09:58,403 Writer#Run Send Primary Message 4
2022-12-16 11:09:58,403 Timer::StartT3Timer, SystemBytes=4
2022-12-16 11:09:58,403 WriteSendMessage: StartT3Timer 4
2022-12-16 11:09:58,403 [SEND] S6F23 W SystemBytes=4
00 00 00 0D 00 00 86 17 00 00 00 00 00 04 A5 01 00 
2022-12-16 11:09:58,403 [SEND] S6F23 W System Bytes=4
<U1 [1] [RSDC]  0 >
.

2022-12-16 11:09:58,493 Timer::StartTimer -8
2022-12-16 11:09:58,493 Timer::StopTimer -8
2022-12-16 11:09:58,493 Read Data: 13 -- 00 00 06 18 00 00 00 00 00 04 21 01 01 
2022-12-16 11:09:58,493 Reader#ByteToBlock Header: 00 00 06 18 00 00 00 00 00 04 
2022-12-16 11:09:58,493 Reader#ByteToBlock Data: 21 01 01 
2022-12-16 11:09:58,493 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:09:58,508 [RECV] S6F24  System Bytes=4 
2022-12-16 11:09:58,508 [RECV] S6F24 System Bytes=4
<B [1] [] '' 01  >
.

2022-12-16 11:09:58,508 Timer::StopT3Timer, SystemBytes=4
2022-12-16 11:09:59,032 Writer#Run Send Primary Message 5
2022-12-16 11:09:59,032 Timer::StartT3Timer, SystemBytes=5
2022-12-16 11:09:59,032 WriteSendMessage: StartT3Timer 5
2022-12-16 11:09:59,032 [SEND] S2F43 W SystemBytes=5
00 00 00 0C 00 00 82 2B 00 00 00 00 00 05 01 00 
2022-12-16 11:09:59,032 [SEND] S2F43 W System Bytes=5
<L [0]
>
.

2022-12-16 11:09:59,166 Timer::StartTimer -8
2022-12-16 11:09:59,166 Timer::StopTimer -8
2022-12-16 11:09:59,166 Read Data: 17 -- 00 00 02 2C 00 00 00 00 00 05 01 02 21 01 00 01 00 
2022-12-16 11:09:59,166 Reader#ByteToBlock Header: 00 00 02 2C 00 00 00 00 00 05 
2022-12-16 11:09:59,166 Reader#ByteToBlock Data: 01 02 21 01 00 01 00 
2022-12-16 11:09:59,166 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:09:59,181 [RECV] S2F44  System Bytes=5 
2022-12-16 11:09:59,181 [RECV] S2F44 System Bytes=5
<L [2]
    <B [1] [] '' 00  >
    <L [0]
    >
>
.

2022-12-16 11:09:59,181 Timer::StopT3Timer, SystemBytes=5
2022-12-16 11:09:59,705 Writer#Run Send Primary Message 6
2022-12-16 11:09:59,705 Timer::StartT3Timer, SystemBytes=6
2022-12-16 11:09:59,705 WriteSendMessage: StartT3Timer 6
2022-12-16 11:09:59,705 [SEND] S2F37 W SystemBytes=6
00 00 00 11 00 00 82 25 00 00 00 00 00 06 01 02 25 01 00 01 00 
2022-12-16 11:09:59,705 [SEND] S2F37 W System Bytes=6
<L [2]
    <BOOLEAN [1] [CEED]  F >
    <L [0]
    >
>
.

2022-12-16 11:09:59,810 Timer::StartTimer -8
2022-12-16 11:09:59,810 Timer::StopTimer -8
2022-12-16 11:09:59,810 Read Data: 13 -- 00 00 02 26 00 00 00 00 00 06 21 01 00 
2022-12-16 11:09:59,810 Reader#ByteToBlock Header: 00 00 02 26 00 00 00 00 00 06 
2022-12-16 11:09:59,810 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:09:59,810 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:09:59,825 [RECV] S2F38  System Bytes=6 
2022-12-16 11:09:59,825 [RECV] S2F38 System Bytes=6
<B [1] [] '' 00  >
.

2022-12-16 11:09:59,825 Timer::StopT3Timer, SystemBytes=6
2022-12-16 11:10:00,349 Writer#Run Send Primary Message 7
2022-12-16 11:10:00,349 Timer::StartT3Timer, SystemBytes=7
2022-12-16 11:10:00,349 WriteSendMessage: StartT3Timer 7
2022-12-16 11:10:00,349 [SEND] S2F35 W SystemBytes=7
00 00 00 14 00 00 82 23 00 00 00 00 00 07 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:10:00,349 [SEND] S2F35 W System Bytes=7
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:10:00,468 Timer::StartTimer -8
2022-12-16 11:10:00,468 Timer::StopTimer -8
2022-12-16 11:10:00,468 Read Data: 13 -- 00 00 02 24 00 00 00 00 00 07 21 01 00 
2022-12-16 11:10:00,468 Reader#ByteToBlock Header: 00 00 02 24 00 00 00 00 00 07 
2022-12-16 11:10:00,468 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:10:00,468 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:10:00,483 [RECV] S2F36  System Bytes=7 
2022-12-16 11:10:00,483 [RECV] S2F36 System Bytes=7
<B [1] [] '' 00  >
.

2022-12-16 11:10:00,483 Timer::StopT3Timer, SystemBytes=7
2022-12-16 11:10:01,007 Writer#Run Send Primary Message 8
2022-12-16 11:10:01,007 Timer::StartT3Timer, SystemBytes=8
2022-12-16 11:10:01,007 WriteSendMessage: StartT3Timer 8
2022-12-16 11:10:01,007 [SEND] S2F33 W SystemBytes=8
00 00 00 14 00 00 82 21 00 00 00 00 00 08 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:10:01,007 [SEND] S2F33 W System Bytes=8
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:10:01,112 Timer::StartTimer -8
2022-12-16 11:10:01,112 Timer::StopTimer -8
2022-12-16 11:10:01,112 Read Data: 13 -- 00 00 02 22 00 00 00 00 00 08 21 01 00 
2022-12-16 11:10:01,112 Reader#ByteToBlock Header: 00 00 02 22 00 00 00 00 00 08 
2022-12-16 11:10:01,112 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:10:01,112 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:10:01,127 [RECV] S2F34  System Bytes=8 
2022-12-16 11:10:01,127 [RECV] S2F34 System Bytes=8
<B [1] [DRACK] '' 00  >
.

2022-12-16 11:10:01,128 Timer::StopT3Timer, SystemBytes=8
2022-12-16 11:10:01,665 Writer#Run Send Primary Message 9
2022-12-16 11:10:01,665 Timer::StartT3Timer, SystemBytes=9
2022-12-16 11:10:01,665 WriteSendMessage: StartT3Timer 9
2022-12-16 11:10:01,665 [SEND] S5F3 W SystemBytes=9
00 00 00 15 00 00 85 03 00 00 00 00 00 09 01 02 21 01 00 B1 04 00 00 00 00 
2022-12-16 11:10:01,665 [SEND] S5F3 W System Bytes=9
<L [2]
    <B [1] [ALED] '' 00  >
    <U4 [1] [ALID]  0 >
>
.

2022-12-16 11:10:01,770 Timer::StartTimer -8
2022-12-16 11:10:01,770 Timer::StopTimer -8
2022-12-16 11:10:01,770 Read Data: 13 -- 00 00 05 04 00 00 00 00 00 09 21 01 00 
2022-12-16 11:10:01,770 Reader#ByteToBlock Header: 00 00 05 04 00 00 00 00 00 09 
2022-12-16 11:10:01,770 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:10:01,770 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:10:01,785 [RECV] S5F4  System Bytes=9 
2022-12-16 11:10:01,785 [RECV] S5F4 System Bytes=9
<B [1] [ACKC5] '' 00  >
.

2022-12-16 11:10:01,785 Timer::StopT3Timer, SystemBytes=9
2022-12-16 11:10:02,308 Writer#Run Send Primary Message 10
2022-12-16 11:10:02,308 Timer::StartT3Timer, SystemBytes=10
2022-12-16 11:10:02,308 WriteSendMessage: StartT3Timer 10
2022-12-16 11:10:02,308 [SEND] S2F33 W SystemBytes=10
00 00 02 18 00 00 82 21 00 00 00 00 00 0A 01 02 B1 04 00 00 00 00 01 0F 01 02 B1 04 00 00 00 01 01 03 B1 04 00 00 4F 4C B1 04 00 00 4F B0 B1 04 00 00 4F B1 01 02 B1 04 00 00 00 0B 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 0C 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 15 01 03 B1 04 00 00 4F 4C B1 04 00 00 51 40 B1 04 00 00 51 44 01 02 B1 04 00 00 00 16 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 17 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 78 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 00 00 79 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 03 0D 4B 01 05 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 41 B1 04 00 00 9C 40 B1 04 00 00 9C 42 01 02 B1 04 00 03 0D 4C 01 0D B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 41 B1 04 00 00 9C 42 B1 04 00 00 9C 4A B1 04 00 00 9C 4B B1 04 00 00 9C 4C B1 04 00 00 9C 4D B1 04 00 00 9C 4E B1 04 00 00 9C 4F B1 04 00 00 9C 50 B1 04 00 00 9C 51 01 02 B1 04 00 03 0D 55 01 03 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 01 02 B1 04 00 03 0D 56 01 0B B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 42 B1 04 00 00 A0 28 B1 04 00 00 A0 2A B1 04 00 00 A0 2B B1 04 00 00 A0 2C B1 04 00 00 A0 2D B1 04 00 00 A0 2E B1 04 00 00 A0 2F 01 02 B1 04 00 03 0D 60 01 02 B1 04 00 00 4F 4C B1 04 00 00 65 90 01 02 B1 04 00 03 0D 69 01 04 B1 04 00 00 4F 4C B1 04 00 00 52 14 B1 04 00 00 52 15 B1 04 00 00 52 16 01 02 B1 04 00 03 0D 7D 01 03 B1 04 00 00 4F 4C B1 04 00 00 52 12 B1 04 00 00 52 13 
2022-12-16 11:10:02,308 [SEND] S2F33 W System Bytes=10
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [15]
        <L [2]
            <U4 [1] [reportid]  1 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentControlState]  20400 >
                <U4 [1] [PreviousControlState]  20401 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  11 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  12 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  21 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
                <U4 [1] [SpoolingState]  20804 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  22 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  23 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  120 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  121 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200011 >
            <L [5]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200012 >
            <L [13]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] [Target A]  40010 >
                <U4 [1] [Target B]  40011 >
                <U4 [1] [Target C]  40012 >
                <U4 [1] [Target D]  40013 >
                <U4 [1] [Reroute A]  40014 >
                <U4 [1] [Reroute B]  40015 >
                <U4 [1] [Reroute C]  40016 >
                <U4 [1] [Reroute D]  40017 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200021 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200022 >
            <L [11]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] []  41000 >
                <U4 [1] []  41002 >
                <U4 [1] []  41003 >
                <U4 [1] []  41004 >
                <U4 [1] []  41005 >
                <U4 [1] []  41006 >
                <U4 [1] []  41007 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200032 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SlotList]  26000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200041 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [UserName]  21012 >
                <U4 [1] [PreviousUserName]  21013 >
                <U4 [1] [LoginState]  21014 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200061 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentEquipmentState]  21010 >
                <U4 [1] [PreviousEquipmentState]  21011 >
            >
        >
    >
>
.

2022-12-16 11:10:47,534 HSMSTimer::CheckT3Timeout: 45.2250987, 10
2022-12-16 11:10:47,534 T3 Timeout: System Bytes=10
2022-12-16 11:10:47,535 Timer#Run: Timeout Message System Bytes=10
2022-12-16 11:10:47,554 SystemBytes: 10, ERRCODE: T3TimeOut, ERRDESC: T3 TimeOut: Reply Timeout..
2022-12-16 11:11:02,319 Timer::StartTimer -8
2022-12-16 11:11:02,319 Timer::StopTimer -8
2022-12-16 11:11:02,319 Read Data: 10 -- FF FF 00 00 00 05 66 78 FF 1A 
2022-12-16 11:11:02,319 Reader#ByteToBlock Header: FF FF 00 00 00 05 66 78 FF 1A 
2022-12-16 11:11:02,319 HSMSPort::OnReadHsms control message.
2022-12-16 11:11:02,319 [RECV] FF FF 00 00 00 05 66 78 FF 1A   LinkTest.Req
2022-12-16 11:11:02,319 [WRITE] [SB:1719205658, 6] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1A 
2022-12-16 11:11:02,320 [SEND] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1A   LinkTest.Rsp
2022-12-16 11:11:56,753 HSMSTimer::CheckOtherTimeout: 120.3520692, -100
2022-12-16 11:11:56,753 Timer::StartTimer -6
2022-12-16 11:11:56,753 [WRITE] [SB:2130706433, 5] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 01 
2022-12-16 11:11:56,753 [SEND] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 01   LinkTest.Req
2022-12-16 11:11:56,753 Timer::StartTimer -100
2022-12-16 11:11:56,769 Timer::StartTimer -8
2022-12-16 11:11:56,769 Timer::StopTimer -8
2022-12-16 11:11:56,769 Read Data: 10 -- FF FF 00 00 00 06 7F 00 00 01 
2022-12-16 11:11:56,769 Reader#ByteToBlock Header: FF FF 00 00 00 06 7F 00 00 01 
2022-12-16 11:11:56,769 HSMSPort::OnReadHsms control message.
2022-12-16 11:11:56,769 Timer::StopTimer -6
2022-12-16 11:11:56,769 [RECV] FF FF 00 00 00 06 7F 00 00 01   LinkTest.Rsp
2022-12-16 11:12:56,782 Timer::StartTimer -8
2022-12-16 11:12:56,782 Timer::StopTimer -8
2022-12-16 11:12:56,782 Read Data: 10 -- FF FF 00 00 00 05 66 78 FF 1B 
2022-12-16 11:12:56,782 Reader#ByteToBlock Header: FF FF 00 00 00 05 66 78 FF 1B 
2022-12-16 11:12:56,782 HSMSPort::OnReadHsms control message.
2022-12-16 11:12:56,782 [RECV] FF FF 00 00 00 05 66 78 FF 1B   LinkTest.Req
2022-12-16 11:12:56,782 [WRITE] [SB:1719205659, 6] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1B 
2022-12-16 11:12:56,782 [SEND] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1B   LinkTest.Rsp
2022-12-16 11:13:56,785 Timer::StartTimer -8
2022-12-16 11:13:56,785 Timer::StopTimer -8
2022-12-16 11:13:56,785 Read Data: 10 -- FF FF 00 00 00 05 66 78 FF 1C 
2022-12-16 11:13:56,785 Reader#ByteToBlock Header: FF FF 00 00 00 05 66 78 FF 1C 
2022-12-16 11:13:56,785 HSMSPort::OnReadHsms control message.
2022-12-16 11:13:56,785 [RECV] FF FF 00 00 00 05 66 78 FF 1C   LinkTest.Req
2022-12-16 11:13:56,785 [WRITE] [SB:1719205660, 6] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1C 
2022-12-16 11:13:56,786 [SEND] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1C   LinkTest.Rsp
2022-12-16 11:13:57,009 HSMSTimer::CheckOtherTimeout: 120.2561144, -100
2022-12-16 11:13:57,009 Timer::StartTimer -6
2022-12-16 11:13:57,009 [WRITE] [SB:2130706434, 5] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 02 
2022-12-16 11:13:57,009 [SEND] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 02   LinkTest.Req
2022-12-16 11:13:57,010 Timer::StartTimer -100
2022-12-16 11:13:57,025 Timer::StartTimer -8
2022-12-16 11:13:57,026 Timer::StopTimer -8
2022-12-16 11:13:57,026 Read Data: 10 -- FF FF 00 00 00 06 7F 00 00 02 
2022-12-16 11:13:57,026 Reader#ByteToBlock Header: FF FF 00 00 00 06 7F 00 00 02 
2022-12-16 11:13:57,026 HSMSPort::OnReadHsms control message.
2022-12-16 11:13:57,026 Timer::StopTimer -6
2022-12-16 11:13:57,026 [RECV] FF FF 00 00 00 06 7F 00 00 02   LinkTest.Rsp
2022-12-16 11:14:57,033 Timer::StartTimer -8
2022-12-16 11:14:57,033 Timer::StopTimer -8
2022-12-16 11:14:57,033 Read Data: 10 -- FF FF 00 00 00 05 66 78 FF 1D 
2022-12-16 11:14:57,033 Reader#ByteToBlock Header: FF FF 00 00 00 05 66 78 FF 1D 
2022-12-16 11:14:57,033 HSMSPort::OnReadHsms control message.
2022-12-16 11:14:57,033 [RECV] FF FF 00 00 00 05 66 78 FF 1D   LinkTest.Req
2022-12-16 11:14:57,033 [WRITE] [SB:1719205661, 6] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1D 
2022-12-16 11:14:57,033 [SEND] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1D   LinkTest.Rsp
2022-12-16 11:16:17,803 Timer::StartTimer -8
2022-12-16 11:16:17,803 HSMSTimer::CheckOtherTimeout: 140.7927774, -100
2022-12-16 11:16:17,803 Timer::StopTimer -8
2022-12-16 11:16:17,803 Timer::StartTimer -6
2022-12-16 11:16:17,803 [WRITE] [SB:2130706435, 5] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 03 
2022-12-16 11:16:17,803 Read Data: 10 -- FF FF 00 00 00 05 66 78 FF 1E 
2022-12-16 11:16:17,803 [SEND] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 03   LinkTest.Req
2022-12-16 11:16:17,803 Timer::StartTimer -100
2022-12-16 11:16:17,803 Reader#ByteToBlock Header: FF FF 00 00 00 05 66 78 FF 1E 
2022-12-16 11:16:17,803 HSMSPort::OnReadHsms control message.
2022-12-16 11:16:17,803 [RECV] FF FF 00 00 00 05 66 78 FF 1E   LinkTest.Req
2022-12-16 11:16:17,803 [WRITE] [SB:1719205662, 6] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1E 
2022-12-16 11:16:17,803 [SEND] 00 00 00 0A FF FF 00 00 00 06 66 78 FF 1E   LinkTest.Rsp
2022-12-16 11:16:17,809 Timer::StartTimer -8
2022-12-16 11:16:17,809 Timer::StopTimer -8
2022-12-16 11:16:17,809 Read Data: 10 -- FF FF 00 00 00 06 7F 00 00 03 
2022-12-16 11:16:17,809 Reader#ByteToBlock Header: FF FF 00 00 00 06 7F 00 00 03 
2022-12-16 11:16:17,809 HSMSPort::OnReadHsms control message.
2022-12-16 11:16:17,809 Timer::StopTimer -6
2022-12-16 11:16:17,809 [RECV] FF FF 00 00 00 06 7F 00 00 03   LinkTest.Rsp
2022-12-16 11:16:17,827 Timer::StartTimer -8
2022-12-16 11:16:17,827 Timer::StopTimer -8
2022-12-16 11:16:17,827 Read Data: 10 -- FF FF 06 03 00 07 66 78 FF 1E 
2022-12-16 11:16:17,827 Reader#ByteToBlock Header: FF FF 06 03 00 07 66 78 FF 1E 
2022-12-16 11:16:17,827 HSMSPort::OnReadHsms control message.
2022-12-16 11:16:17,827 [RECV] FF FF 06 03 00 07 66 78 FF 1E   Reject.Req
2022-12-16 11:28:59,244 Start to Open the MARK_01 SECS Port
2022-12-16 11:28:59,244 SECSwell Version:4.0.1.17
2022-12-16 11:28:59,935 Start S9FxMonitor Thread.
2022-12-16 11:28:59,937 S9FxMonitor Thread Status = True
2022-12-16 11:28:59,937 HSMSPort::Initialize execute.
2022-12-16 11:28:59,939 Start - Connector Thread.
2022-12-16 11:28:59,942 - Connector Thread Status = True
2022-12-16 11:28:59,943 Start MARK_01#Parser Thread.
2022-12-16 11:28:59,970 MARK_01#Parser Thread Status = True
2022-12-16 11:28:59,975 Start MARK_01#Timer Thread.
2022-12-16 11:28:59,975 Completely Open the MARK_01 SECS Port
2022-12-16 11:28:59,975 HSMSPort::OnConnected Status=-4
2022-12-16 11:28:59,977 MARK_01#Timer Thread Status = True
2022-12-16 11:28:59,979 UpdateStatus: Prev:-3=>Now:-4=>New:0
2022-12-16 11:28:59,981 UpdateStatus: Prev:-4=>Now:0
2022-12-16 11:28:59,982 Start MARK_01#Reader Thread.
2022-12-16 11:28:59,986 MARK_01#Reader Thread Status = True
2022-12-16 11:28:59,988 Start MARK_01#Writer Thread.
2022-12-16 11:28:59,992 MARK_01#Writer Thread Status = True
2022-12-16 11:28:59,993 Timer::StartTimer -100
2022-12-16 11:28:59,994 Timer::StartTimer -6
2022-12-16 11:29:00,002 [WRITE] [SB:2130706432, 1] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00 
2022-12-16 11:29:00,003 [SEND] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00   Select.Req
2022-12-16 11:29:00,048 Timer::StartTimer -8
2022-12-16 11:29:00,049 Timer::StopTimer -8
2022-12-16 11:29:00,049 Read Data: 10 -- FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:29:00,049 Reader#ByteToBlock Header: FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:29:00,050 HSMSPort::OnReadHsms control message.
2022-12-16 11:29:00,050 Timer::StopTimer -6
2022-12-16 11:29:00,050 [RECV] FF FF 00 00 00 02 7F 00 00 00   Select.Rsp
2022-12-16 11:29:00,050 UpdateStatus: Prev:-4=>Now:0=>New:1
2022-12-16 11:29:00,050 UpdateStatus: Prev:0=>Now:1
2022-12-16 11:29:00,074 Writer#Run Send Primary Message 1
2022-12-16 11:29:00,080 Timer::StartT3Timer, SystemBytes=1
2022-12-16 11:29:00,080 WriteSendMessage: StartT3Timer 1
2022-12-16 11:29:00,080 [SEND] S1F13 W SystemBytes=1
00 00 00 0C 00 00 81 0D 00 00 00 00 00 01 01 00 
2022-12-16 11:29:00,081 [SEND] S1F13 W System Bytes=1
<L [0]
>
.

2022-12-16 11:29:00,178 Timer::StartTimer -8
2022-12-16 11:29:00,178 Timer::StopTimer -8
2022-12-16 11:29:00,178 Read Data: 33 -- 00 00 01 0E 00 00 00 00 00 01 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:29:00,178 Reader#ByteToBlock Header: 00 00 01 0E 00 00 00 00 00 01 
2022-12-16 11:29:00,178 Reader#ByteToBlock Data: 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:29:00,178 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:00,195 [RECV] S1F14  System Bytes=1 
2022-12-16 11:29:00,200 [RECV] S1F14 System Bytes=1
<L [2]
    <B [1] [COMMACK] '' 00  >
    <L [2]
        <A [6] []  '      ' >
        <A [6] []  '      ' >
    >
>
.

2022-12-16 11:29:00,202 Timer::StopT3Timer, SystemBytes=1
2022-12-16 11:29:00,732 Writer#Run Send Primary Message 2
2022-12-16 11:29:00,732 Timer::StartT3Timer, SystemBytes=2
2022-12-16 11:29:00,732 WriteSendMessage: StartT3Timer 2
2022-12-16 11:29:00,732 [SEND] S1F17 W SystemBytes=2
00 00 00 0A 00 00 81 11 00 00 00 00 00 02 
2022-12-16 11:29:00,732 [SEND] S1F17 W System Bytes=2

2022-12-16 11:29:00,837 Timer::StartTimer -8
2022-12-16 11:29:00,837 Timer::StopTimer -8
2022-12-16 11:29:00,837 Read Data: 13 -- 00 00 01 12 00 00 00 00 00 02 21 01 00 
2022-12-16 11:29:00,837 Reader#ByteToBlock Header: 00 00 01 12 00 00 00 00 00 02 
2022-12-16 11:29:00,837 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:29:00,837 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:00,852 [RECV] S1F18  System Bytes=2 
2022-12-16 11:29:00,852 [RECV] S1F18 System Bytes=2
<B [1] [] '' 00  >
.

2022-12-16 11:29:00,852 Timer::StopT3Timer, SystemBytes=2
2022-12-16 11:29:01,375 Writer#Run Send Primary Message 3
2022-12-16 11:29:01,375 Timer::StartT3Timer, SystemBytes=3
2022-12-16 11:29:01,375 WriteSendMessage: StartT3Timer 3
2022-12-16 11:29:01,375 [SEND] S1F3 W SystemBytes=3
00 00 00 42 00 00 81 03 00 00 00 00 00 03 01 09 B1 04 00 00 4F 4C B1 04 00 00 51 54 B1 04 00 00 4F B0 B1 04 00 00 4F B1 B1 04 00 00 52 12 B1 04 00 00 52 13 B1 04 00 00 51 44 B1 04 00 00 51 40 B1 04 00 00 51 41 
2022-12-16 11:29:01,375 [SEND] S1F3 W System Bytes=3
<L [9]
    <U4 [1] [Clock]  20300 >
    <U4 [1] [CommunicationState]  20820 >
    <U4 [1] [CurrentControlState]  20400 >
    <U4 [1] [PreviousControlState]  20401 >
    <U4 [1] [CurrentEquipmentState]  21010 >
    <U4 [1] [PreviousEquipmentState]  21011 >
    <U4 [1] [SpoolingState]  20804 >
    <U4 [1] [SpoolCountActual]  20800 >
    <U4 [1] [SpoolCountTotal]  20801 >
>
.

2022-12-16 11:29:01,480 Timer::StartTimer -8
2022-12-16 11:29:01,480 Timer::StopTimer -8
2022-12-16 11:29:01,480 Read Data: 71 -- 00 00 01 04 00 00 00 00 00 03 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:29:01,480 Reader#ByteToBlock Header: 00 00 01 04 00 00 00 00 00 03 
2022-12-16 11:29:01,480 Reader#ByteToBlock Data: 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:29:01,480 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:01,495 [RECV] S1F4  System Bytes=3 
2022-12-16 11:29:01,496 [RECV] S1F4 System Bytes=3
<L [10]
    <A [19] [SVID]  '2021-09-17T13:48:25' >
    <U1 [1] []  0 >
    <U1 [1] []  4 >
    <U1 [1] []  5 >
    <U2 [1] []  2000 >
    <U2 [1] []  1000 >
    <A [4] []  'test' >
    <U1 [1] []  0 >
    <U4 [1] []  0 >
    <U4 [1] []  0 >
>
.

2022-12-16 11:29:01,496 Timer::StopT3Timer, SystemBytes=3
2022-12-16 11:29:02,019 Writer#Run Send Primary Message 4
2022-12-16 11:29:02,019 Timer::StartT3Timer, SystemBytes=4
2022-12-16 11:29:02,019 WriteSendMessage: StartT3Timer 4
2022-12-16 11:29:02,019 [SEND] S6F23 W SystemBytes=4
00 00 00 0D 00 00 86 17 00 00 00 00 00 04 A5 01 00 
2022-12-16 11:29:02,019 [SEND] S6F23 W System Bytes=4
<U1 [1] [RSDC]  0 >
.

2022-12-16 11:29:02,123 Timer::StartTimer -8
2022-12-16 11:29:02,123 Timer::StopTimer -8
2022-12-16 11:29:02,123 Read Data: 13 -- 00 00 06 18 00 00 00 00 00 04 21 01 01 
2022-12-16 11:29:02,123 Reader#ByteToBlock Header: 00 00 06 18 00 00 00 00 00 04 
2022-12-16 11:29:02,123 Reader#ByteToBlock Data: 21 01 01 
2022-12-16 11:29:02,123 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:02,138 [RECV] S6F24  System Bytes=4 
2022-12-16 11:29:02,138 [RECV] S6F24 System Bytes=4
<B [1] [] '' 01  >
.

2022-12-16 11:29:02,138 Timer::StopT3Timer, SystemBytes=4
2022-12-16 11:29:02,663 Writer#Run Send Primary Message 5
2022-12-16 11:29:02,663 Timer::StartT3Timer, SystemBytes=5
2022-12-16 11:29:02,663 WriteSendMessage: StartT3Timer 5
2022-12-16 11:29:02,663 [SEND] S2F43 W SystemBytes=5
00 00 00 0C 00 00 82 2B 00 00 00 00 00 05 01 00 
2022-12-16 11:29:02,663 [SEND] S2F43 W System Bytes=5
<L [0]
>
.

2022-12-16 11:29:02,768 Timer::StartTimer -8
2022-12-16 11:29:02,768 Timer::StopTimer -8
2022-12-16 11:29:02,768 Read Data: 17 -- 00 00 02 2C 00 00 00 00 00 05 01 02 21 01 00 01 00 
2022-12-16 11:29:02,768 Reader#ByteToBlock Header: 00 00 02 2C 00 00 00 00 00 05 
2022-12-16 11:29:02,768 Reader#ByteToBlock Data: 01 02 21 01 00 01 00 
2022-12-16 11:29:02,768 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:02,783 [RECV] S2F44  System Bytes=5 
2022-12-16 11:29:02,783 [RECV] S2F44 System Bytes=5
<L [2]
    <B [1] [] '' 00  >
    <L [0]
    >
>
.

2022-12-16 11:29:02,783 Timer::StopT3Timer, SystemBytes=5
2022-12-16 11:29:03,306 Writer#Run Send Primary Message 6
2022-12-16 11:29:03,306 Timer::StartT3Timer, SystemBytes=6
2022-12-16 11:29:03,306 WriteSendMessage: StartT3Timer 6
2022-12-16 11:29:03,306 [SEND] S2F37 W SystemBytes=6
00 00 00 11 00 00 82 25 00 00 00 00 00 06 01 02 25 01 00 01 00 
2022-12-16 11:29:03,306 [SEND] S2F37 W System Bytes=6
<L [2]
    <BOOLEAN [1] [CEED]  F >
    <L [0]
    >
>
.

2022-12-16 11:29:03,411 Timer::StartTimer -8
2022-12-16 11:29:03,411 Timer::StopTimer -8
2022-12-16 11:29:03,411 Read Data: 13 -- 00 00 02 26 00 00 00 00 00 06 21 01 00 
2022-12-16 11:29:03,411 Reader#ByteToBlock Header: 00 00 02 26 00 00 00 00 00 06 
2022-12-16 11:29:03,411 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:29:03,411 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:03,426 [RECV] S2F38  System Bytes=6 
2022-12-16 11:29:03,431 [RECV] S2F38 System Bytes=6
<B [1] [] '' 00  >
.

2022-12-16 11:29:03,431 Timer::StopT3Timer, SystemBytes=6
2022-12-16 11:29:03,964 Writer#Run Send Primary Message 7
2022-12-16 11:29:03,964 Timer::StartT3Timer, SystemBytes=7
2022-12-16 11:29:03,964 WriteSendMessage: StartT3Timer 7
2022-12-16 11:29:03,964 [SEND] S2F35 W SystemBytes=7
00 00 00 14 00 00 82 23 00 00 00 00 00 07 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:29:03,964 [SEND] S2F35 W System Bytes=7
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:29:04,054 Timer::StartTimer -8
2022-12-16 11:29:04,054 Timer::StopTimer -8
2022-12-16 11:29:04,054 Read Data: 13 -- 00 00 02 24 00 00 00 00 00 07 21 01 00 
2022-12-16 11:29:04,054 Reader#ByteToBlock Header: 00 00 02 24 00 00 00 00 00 07 
2022-12-16 11:29:04,054 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:29:04,054 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:04,069 [RECV] S2F36  System Bytes=7 
2022-12-16 11:29:04,069 [RECV] S2F36 System Bytes=7
<B [1] [] '' 00  >
.

2022-12-16 11:29:04,069 Timer::StopT3Timer, SystemBytes=7
2022-12-16 11:29:04,593 Writer#Run Send Primary Message 8
2022-12-16 11:29:04,593 Timer::StartT3Timer, SystemBytes=8
2022-12-16 11:29:04,593 WriteSendMessage: StartT3Timer 8
2022-12-16 11:29:04,593 [SEND] S2F33 W SystemBytes=8
00 00 00 14 00 00 82 21 00 00 00 00 00 08 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:29:04,593 [SEND] S2F33 W System Bytes=8
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:29:04,697 Timer::StartTimer -8
2022-12-16 11:29:04,697 Timer::StopTimer -8
2022-12-16 11:29:04,697 Read Data: 13 -- 00 00 02 22 00 00 00 00 00 08 21 01 00 
2022-12-16 11:29:04,697 Reader#ByteToBlock Header: 00 00 02 22 00 00 00 00 00 08 
2022-12-16 11:29:04,697 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:29:04,697 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:04,712 [RECV] S2F34  System Bytes=8 
2022-12-16 11:29:04,712 [RECV] S2F34 System Bytes=8
<B [1] [DRACK] '' 00  >
.

2022-12-16 11:29:04,712 Timer::StopT3Timer, SystemBytes=8
2022-12-16 11:29:05,236 Writer#Run Send Primary Message 9
2022-12-16 11:29:05,236 Timer::StartT3Timer, SystemBytes=9
2022-12-16 11:29:05,236 WriteSendMessage: StartT3Timer 9
2022-12-16 11:29:05,236 [SEND] S5F3 W SystemBytes=9
00 00 00 15 00 00 85 03 00 00 00 00 00 09 01 02 21 01 00 B1 04 00 00 00 00 
2022-12-16 11:29:05,236 [SEND] S5F3 W System Bytes=9
<L [2]
    <B [1] [ALED] '' 00  >
    <U4 [1] [ALID]  0 >
>
.

2022-12-16 11:29:05,341 Timer::StartTimer -8
2022-12-16 11:29:05,341 Timer::StopTimer -8
2022-12-16 11:29:05,341 Read Data: 13 -- 00 00 05 04 00 00 00 00 00 09 21 01 00 
2022-12-16 11:29:05,341 Reader#ByteToBlock Header: 00 00 05 04 00 00 00 00 00 09 
2022-12-16 11:29:05,341 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:29:05,341 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:29:05,356 [RECV] S5F4  System Bytes=9 
2022-12-16 11:29:05,356 [RECV] S5F4 System Bytes=9
<B [1] [ACKC5] '' 00  >
.

2022-12-16 11:29:05,356 Timer::StopT3Timer, SystemBytes=9
2022-12-16 11:29:05,879 Writer#Run Send Primary Message 10
2022-12-16 11:29:05,879 Timer::StartT3Timer, SystemBytes=10
2022-12-16 11:29:05,879 WriteSendMessage: StartT3Timer 10
2022-12-16 11:29:05,879 [SEND] S2F33 W SystemBytes=10
00 00 02 18 00 00 82 21 00 00 00 00 00 0A 01 02 B1 04 00 00 00 00 01 0F 01 02 B1 04 00 00 00 01 01 03 B1 04 00 00 4F 4C B1 04 00 00 4F B0 B1 04 00 00 4F B1 01 02 B1 04 00 00 00 0B 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 0C 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 15 01 03 B1 04 00 00 4F 4C B1 04 00 00 51 40 B1 04 00 00 51 44 01 02 B1 04 00 00 00 16 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 17 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 78 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 00 00 79 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 03 0D 4B 01 05 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 41 B1 04 00 00 9C 40 B1 04 00 00 9C 42 01 02 B1 04 00 03 0D 4C 01 0D B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 41 B1 04 00 00 9C 42 B1 04 00 00 9C 4A B1 04 00 00 9C 4B B1 04 00 00 9C 4C B1 04 00 00 9C 4D B1 04 00 00 9C 4E B1 04 00 00 9C 4F B1 04 00 00 9C 50 B1 04 00 00 9C 51 01 02 B1 04 00 03 0D 55 01 03 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 01 02 B1 04 00 03 0D 56 01 0B B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 42 B1 04 00 00 A0 28 B1 04 00 00 A0 2A B1 04 00 00 A0 2B B1 04 00 00 A0 2C B1 04 00 00 A0 2D B1 04 00 00 A0 2E B1 04 00 00 A0 2F 01 02 B1 04 00 03 0D 60 01 02 B1 04 00 00 4F 4C B1 04 00 00 65 90 01 02 B1 04 00 03 0D 69 01 04 B1 04 00 00 4F 4C B1 04 00 00 52 14 B1 04 00 00 52 15 B1 04 00 00 52 16 01 02 B1 04 00 03 0D 7D 01 03 B1 04 00 00 4F 4C B1 04 00 00 52 12 B1 04 00 00 52 13 
2022-12-16 11:29:05,879 [SEND] S2F33 W System Bytes=10
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [15]
        <L [2]
            <U4 [1] [reportid]  1 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentControlState]  20400 >
                <U4 [1] [PreviousControlState]  20401 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  11 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  12 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  21 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
                <U4 [1] [SpoolingState]  20804 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  22 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  23 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  120 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  121 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200011 >
            <L [5]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200012 >
            <L [13]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] [Target A]  40010 >
                <U4 [1] [Target B]  40011 >
                <U4 [1] [Target C]  40012 >
                <U4 [1] [Target D]  40013 >
                <U4 [1] [Reroute A]  40014 >
                <U4 [1] [Reroute B]  40015 >
                <U4 [1] [Reroute C]  40016 >
                <U4 [1] [Reroute D]  40017 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200021 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200022 >
            <L [11]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] []  41000 >
                <U4 [1] []  41002 >
                <U4 [1] []  41003 >
                <U4 [1] []  41004 >
                <U4 [1] []  41005 >
                <U4 [1] []  41006 >
                <U4 [1] []  41007 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200032 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SlotList]  26000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200041 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [UserName]  21012 >
                <U4 [1] [PreviousUserName]  21013 >
                <U4 [1] [LoginState]  21014 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200061 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentEquipmentState]  21010 >
                <U4 [1] [PreviousEquipmentState]  21011 >
            >
        >
    >
>
.

2022-12-16 11:29:51,114 HSMSTimer::CheckT3Timeout: 45.2350322, 10
2022-12-16 11:29:51,114 T3 Timeout: System Bytes=10
2022-12-16 11:29:51,115 Timer#Run: Timeout Message System Bytes=10
2022-12-16 11:29:51,138 SystemBytes: 10, ERRCODE: T3TimeOut, ERRDESC: T3 TimeOut: Reply Timeout..
2022-12-16 11:30:05,885 Timer::StartTimer -8
2022-12-16 11:30:05,885 Timer::StopTimer -8
2022-12-16 11:30:05,885 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 14 
2022-12-16 11:30:05,885 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 14 
2022-12-16 11:30:05,885 HSMSPort::OnReadHsms control message.
2022-12-16 11:30:05,885 [RECV] FF FF 00 00 00 05 0F 16 54 14   LinkTest.Req
2022-12-16 11:30:05,885 [WRITE] [SB:253121556, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 14 
2022-12-16 11:30:05,885 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 14   LinkTest.Rsp
2022-12-16 11:37:32,936 Timer::StartTimer -8
2022-12-16 11:37:32,936 Timer::StopTimer -8
2022-12-16 11:37:32,936 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 15 
2022-12-16 11:37:32,936 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 15 
2022-12-16 11:37:32,936 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,936 HSMSTimer::CheckOtherTimeout: 512.9465008, -100
2022-12-16 11:37:32,936 [RECV] FF FF 00 00 00 05 0F 16 54 15   LinkTest.Req
2022-12-16 11:37:32,936 [WRITE] [SB:253121557, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 15 
2022-12-16 11:37:32,937 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 15   LinkTest.Rsp
2022-12-16 11:37:32,937 Timer::StartTimer -8
2022-12-16 11:37:32,937 Timer::StopTimer -8
2022-12-16 11:37:32,937 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 16 
2022-12-16 11:37:32,937 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 16 
2022-12-16 11:37:32,937 Timer::StartTimer -6
2022-12-16 11:37:32,937 [WRITE] [SB:2130706433, 5] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 01 
2022-12-16 11:37:32,937 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,937 [RECV] FF FF 00 00 00 05 0F 16 54 16   LinkTest.Req
2022-12-16 11:37:32,937 [WRITE] [SB:253121558, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 16 
2022-12-16 11:37:32,937 [SEND] 00 00 00 0A FF FF 00 00 00 05 7F 00 00 01   LinkTest.Req
2022-12-16 11:37:32,937 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 16   LinkTest.Rsp
2022-12-16 11:37:32,937 Timer::StartTimer -100
2022-12-16 11:37:32,937 Timer::StartTimer -8
2022-12-16 11:37:32,937 Timer::StopTimer -8
2022-12-16 11:37:32,937 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 17 
2022-12-16 11:37:32,937 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 17 
2022-12-16 11:37:32,937 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,937 [RECV] FF FF 00 00 00 05 0F 16 54 17   LinkTest.Req
2022-12-16 11:37:32,937 [WRITE] [SB:253121559, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 17 
2022-12-16 11:37:32,937 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 17   LinkTest.Rsp
2022-12-16 11:37:32,937 Timer::StartTimer -8
2022-12-16 11:37:32,940 Timer::StopTimer -8
2022-12-16 11:37:32,940 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 18 
2022-12-16 11:37:32,940 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 18 
2022-12-16 11:37:32,940 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,940 [RECV] FF FF 00 00 00 05 0F 16 54 18   LinkTest.Req
2022-12-16 11:37:32,940 [WRITE] [SB:253121560, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 18 
2022-12-16 11:37:32,940 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 18   LinkTest.Rsp
2022-12-16 11:37:32,940 Timer::StartTimer -8
2022-12-16 11:37:32,940 Timer::StopTimer -8
2022-12-16 11:37:32,940 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 19 
2022-12-16 11:37:32,940 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 19 
2022-12-16 11:37:32,940 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,940 [RECV] FF FF 00 00 00 05 0F 16 54 19   LinkTest.Req
2022-12-16 11:37:32,940 [WRITE] [SB:253121561, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 19 
2022-12-16 11:37:32,940 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 19   LinkTest.Rsp
2022-12-16 11:37:32,940 Timer::StartTimer -8
2022-12-16 11:37:32,940 Timer::StopTimer -8
2022-12-16 11:37:32,940 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 1A 
2022-12-16 11:37:32,940 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 1A 
2022-12-16 11:37:32,940 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,940 [RECV] FF FF 00 00 00 05 0F 16 54 1A   LinkTest.Req
2022-12-16 11:37:32,940 [WRITE] [SB:253121562, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 1A 
2022-12-16 11:37:32,940 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 1A   LinkTest.Rsp
2022-12-16 11:37:32,941 Timer::StartTimer -8
2022-12-16 11:37:32,941 Timer::StopTimer -8
2022-12-16 11:37:32,941 Read Data: 10 -- FF FF 00 00 00 05 0F 16 54 1B 
2022-12-16 11:37:32,941 Reader#ByteToBlock Header: FF FF 00 00 00 05 0F 16 54 1B 
2022-12-16 11:37:32,941 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,941 [RECV] FF FF 00 00 00 05 0F 16 54 1B   LinkTest.Req
2022-12-16 11:37:32,941 [WRITE] [SB:253121563, 6] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 1B 
2022-12-16 11:37:32,941 [SEND] 00 00 00 0A FF FF 00 00 00 06 0F 16 54 1B   LinkTest.Rsp
2022-12-16 11:37:32,959 Timer::StartTimer -8
2022-12-16 11:37:32,959 Timer::StopTimer -8
2022-12-16 11:37:32,959 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 15 
2022-12-16 11:37:32,959 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 15 
2022-12-16 11:37:32,959 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,959 [RECV] FF FF 06 03 00 07 0F 16 54 15   Reject.Req
2022-12-16 11:37:32,959 Timer::StartTimer -8
2022-12-16 11:37:32,959 Timer::StopTimer -8
2022-12-16 11:37:32,959 Read Data: 10 -- FF FF 00 00 00 06 7F 00 00 01 
2022-12-16 11:37:32,959 Reader#ByteToBlock Header: FF FF 00 00 00 06 7F 00 00 01 
2022-12-16 11:37:32,959 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:32,959 Timer::StopTimer -6
2022-12-16 11:37:32,959 [RECV] FF FF 00 00 00 06 7F 00 00 01   LinkTest.Rsp
2022-12-16 11:37:35,443 Timer::StartTimer -8
2022-12-16 11:37:35,444 Timer::StopTimer -8
2022-12-16 11:37:35,444 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 16 
2022-12-16 11:37:35,444 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 16 
2022-12-16 11:37:35,444 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:35,444 [RECV] FF FF 06 03 00 07 0F 16 54 16   Reject.Req
2022-12-16 11:37:35,444 Timer::StartTimer -8
2022-12-16 11:37:35,444 Timer::StopTimer -8
2022-12-16 11:37:35,444 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 17 
2022-12-16 11:37:35,444 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 17 
2022-12-16 11:37:35,444 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:35,444 [RECV] FF FF 06 03 00 07 0F 16 54 17   Reject.Req
2022-12-16 11:37:35,444 Timer::StartTimer -8
2022-12-16 11:37:35,444 Timer::StopTimer -8
2022-12-16 11:37:35,444 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 18 
2022-12-16 11:37:35,444 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 18 
2022-12-16 11:37:35,444 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:35,444 [RECV] FF FF 06 03 00 07 0F 16 54 18   Reject.Req
2022-12-16 11:37:35,444 Timer::StartTimer -8
2022-12-16 11:37:35,444 Timer::StopTimer -8
2022-12-16 11:37:35,444 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 19 
2022-12-16 11:37:35,444 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 19 
2022-12-16 11:37:35,445 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:35,445 [RECV] FF FF 06 03 00 07 0F 16 54 19   Reject.Req
2022-12-16 11:37:35,445 Timer::StartTimer -8
2022-12-16 11:37:35,445 Timer::StopTimer -8
2022-12-16 11:37:35,445 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 1A 
2022-12-16 11:37:35,445 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 1A 
2022-12-16 11:37:35,445 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:35,445 [RECV] FF FF 06 03 00 07 0F 16 54 1A   Reject.Req
2022-12-16 11:37:35,445 Timer::StartTimer -8
2022-12-16 11:37:35,445 Timer::StopTimer -8
2022-12-16 11:37:35,445 Read Data: 10 -- FF FF 06 03 00 07 0F 16 54 1B 
2022-12-16 11:37:35,445 Reader#ByteToBlock Header: FF FF 06 03 00 07 0F 16 54 1B 
2022-12-16 11:37:35,445 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:35,445 [RECV] FF FF 06 03 00 07 0F 16 54 1B   Reject.Req
2022-12-16 11:37:58,232 Start to Open the MARK_01 SECS Port
2022-12-16 11:37:58,232 SECSwell Version:4.0.1.17
2022-12-16 11:37:58,878 Start S9FxMonitor Thread.
2022-12-16 11:37:58,880 S9FxMonitor Thread Status = True
2022-12-16 11:37:58,880 HSMSPort::Initialize execute.
2022-12-16 11:37:58,882 Start - Connector Thread.
2022-12-16 11:37:58,884 - Connector Thread Status = True
2022-12-16 11:37:58,885 Start MARK_01#Parser Thread.
2022-12-16 11:37:58,887 MARK_01#Parser Thread Status = True
2022-12-16 11:37:58,892 Start MARK_01#Timer Thread.
2022-12-16 11:37:58,892 Completely Open the MARK_01 SECS Port
2022-12-16 11:37:58,893 HSMSPort::OnConnected Status=-4
2022-12-16 11:37:58,894 MARK_01#Timer Thread Status = True
2022-12-16 11:37:58,896 UpdateStatus: Prev:-3=>Now:-4=>New:0
2022-12-16 11:37:58,898 UpdateStatus: Prev:-4=>Now:0
2022-12-16 11:37:58,899 Start MARK_01#Reader Thread.
2022-12-16 11:37:58,902 MARK_01#Reader Thread Status = True
2022-12-16 11:37:58,903 Start MARK_01#Writer Thread.
2022-12-16 11:37:58,906 MARK_01#Writer Thread Status = True
2022-12-16 11:37:58,906 Timer::StartTimer -100
2022-12-16 11:37:58,907 Timer::StartTimer -6
2022-12-16 11:37:58,912 [WRITE] [SB:2130706432, 1] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00 
2022-12-16 11:37:58,913 [SEND] 00 00 00 0A FF FF 00 00 00 01 7F 00 00 00   Select.Req
2022-12-16 11:37:58,976 Timer::StartTimer -8
2022-12-16 11:37:58,978 Timer::StopTimer -8
2022-12-16 11:37:58,978 Read Data: 10 -- FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:37:58,978 Reader#ByteToBlock Header: FF FF 00 00 00 02 7F 00 00 00 
2022-12-16 11:37:58,979 HSMSPort::OnReadHsms control message.
2022-12-16 11:37:58,980 Timer::StopTimer -6
2022-12-16 11:37:58,980 [RECV] FF FF 00 00 00 02 7F 00 00 00   Select.Rsp
2022-12-16 11:37:58,980 UpdateStatus: Prev:-4=>Now:0=>New:1
2022-12-16 11:37:58,980 UpdateStatus: Prev:0=>Now:1
2022-12-16 11:37:59,017 Writer#Run Send Primary Message 1
2022-12-16 11:37:59,022 Timer::StartT3Timer, SystemBytes=1
2022-12-16 11:37:59,022 WriteSendMessage: StartT3Timer 1
2022-12-16 11:37:59,022 [SEND] S1F13 W SystemBytes=1
00 00 00 0C 00 00 81 0D 00 00 00 00 00 01 01 00 
2022-12-16 11:37:59,022 [SEND] S1F13 W System Bytes=1
<L [0]
>
.

2022-12-16 11:37:59,107 Timer::StartTimer -8
2022-12-16 11:37:59,107 Timer::StopTimer -8
2022-12-16 11:37:59,107 Read Data: 33 -- 00 00 01 0E 00 00 00 00 00 01 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:37:59,107 Reader#ByteToBlock Header: 00 00 01 0E 00 00 00 00 00 01 
2022-12-16 11:37:59,107 Reader#ByteToBlock Data: 01 02 21 01 00 01 02 41 06 20 20 20 20 20 20 41 06 20 20 20 20 20 20 
2022-12-16 11:37:59,107 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:37:59,125 [RECV] S1F14  System Bytes=1 
2022-12-16 11:37:59,128 [RECV] S1F14 System Bytes=1
<L [2]
    <B [1] [COMMACK] '' 00  >
    <L [2]
        <A [6] []  '      ' >
        <A [6] []  '      ' >
    >
>
.

2022-12-16 11:37:59,130 Timer::StopT3Timer, SystemBytes=1
2022-12-16 11:37:59,661 Writer#Run Send Primary Message 2
2022-12-16 11:37:59,661 Timer::StartT3Timer, SystemBytes=2
2022-12-16 11:37:59,661 WriteSendMessage: StartT3Timer 2
2022-12-16 11:37:59,661 [SEND] S1F17 W SystemBytes=2
00 00 00 0A 00 00 81 11 00 00 00 00 00 02 
2022-12-16 11:37:59,661 [SEND] S1F17 W System Bytes=2

2022-12-16 11:37:59,765 Timer::StartTimer -8
2022-12-16 11:37:59,765 Timer::StopTimer -8
2022-12-16 11:37:59,765 Read Data: 13 -- 00 00 01 12 00 00 00 00 00 02 21 01 00 
2022-12-16 11:37:59,765 Reader#ByteToBlock Header: 00 00 01 12 00 00 00 00 00 02 
2022-12-16 11:37:59,765 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:37:59,765 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:37:59,780 [RECV] S1F18  System Bytes=2 
2022-12-16 11:37:59,780 [RECV] S1F18 System Bytes=2
<B [1] [] '' 00  >
.

2022-12-16 11:37:59,780 Timer::StopT3Timer, SystemBytes=2
2022-12-16 11:38:00,304 Writer#Run Send Primary Message 3
2022-12-16 11:38:00,304 Timer::StartT3Timer, SystemBytes=3
2022-12-16 11:38:00,304 WriteSendMessage: StartT3Timer 3
2022-12-16 11:38:00,304 [SEND] S1F3 W SystemBytes=3
00 00 00 42 00 00 81 03 00 00 00 00 00 03 01 09 B1 04 00 00 4F 4C B1 04 00 00 51 54 B1 04 00 00 4F B0 B1 04 00 00 4F B1 B1 04 00 00 52 12 B1 04 00 00 52 13 B1 04 00 00 51 44 B1 04 00 00 51 40 B1 04 00 00 51 41 
2022-12-16 11:38:00,304 [SEND] S1F3 W System Bytes=3
<L [9]
    <U4 [1] [Clock]  20300 >
    <U4 [1] [CommunicationState]  20820 >
    <U4 [1] [CurrentControlState]  20400 >
    <U4 [1] [PreviousControlState]  20401 >
    <U4 [1] [CurrentEquipmentState]  21010 >
    <U4 [1] [PreviousEquipmentState]  21011 >
    <U4 [1] [SpoolingState]  20804 >
    <U4 [1] [SpoolCountActual]  20800 >
    <U4 [1] [SpoolCountTotal]  20801 >
>
.

2022-12-16 11:38:00,424 Timer::StartTimer -8
2022-12-16 11:38:00,424 Timer::StopTimer -8
2022-12-16 11:38:00,424 Read Data: 71 -- 00 00 01 04 00 00 00 00 00 03 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:38:00,424 Reader#ByteToBlock Header: 00 00 01 04 00 00 00 00 00 03 
2022-12-16 11:38:00,424 Reader#ByteToBlock Data: 01 0A 41 13 32 30 32 31 2D 30 39 2D 31 37 54 31 33 3A 34 38 3A 32 35 A5 01 00 A5 01 04 A5 01 05 A9 02 07 D0 A9 02 03 E8 41 04 74 65 73 74 A5 01 00 B1 04 00 00 00 00 B1 04 00 00 00 00 
2022-12-16 11:38:00,424 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:00,439 [RECV] S1F4  System Bytes=3 
2022-12-16 11:38:00,441 [RECV] S1F4 System Bytes=3
<L [10]
    <A [19] [SVID]  '2021-09-17T13:48:25' >
    <U1 [1] []  0 >
    <U1 [1] []  4 >
    <U1 [1] []  5 >
    <U2 [1] []  2000 >
    <U2 [1] []  1000 >
    <A [4] []  'test' >
    <U1 [1] []  0 >
    <U4 [1] []  0 >
    <U4 [1] []  0 >
>
.

2022-12-16 11:38:00,442 Timer::StopT3Timer, SystemBytes=3
2022-12-16 11:38:00,977 Writer#Run Send Primary Message 4
2022-12-16 11:38:00,977 Timer::StartT3Timer, SystemBytes=4
2022-12-16 11:38:00,977 WriteSendMessage: StartT3Timer 4
2022-12-16 11:38:00,977 [SEND] S6F23 W SystemBytes=4
00 00 00 0D 00 00 86 17 00 00 00 00 00 04 A5 01 00 
2022-12-16 11:38:00,977 [SEND] S6F23 W System Bytes=4
<U1 [1] [RSDC]  0 >
.

2022-12-16 11:38:01,067 Timer::StartTimer -8
2022-12-16 11:38:01,067 Timer::StopTimer -8
2022-12-16 11:38:01,067 Read Data: 13 -- 00 00 06 18 00 00 00 00 00 04 21 01 01 
2022-12-16 11:38:01,067 Reader#ByteToBlock Header: 00 00 06 18 00 00 00 00 00 04 
2022-12-16 11:38:01,067 Reader#ByteToBlock Data: 21 01 01 
2022-12-16 11:38:01,067 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:01,082 [RECV] S6F24  System Bytes=4 
2022-12-16 11:38:01,082 [RECV] S6F24 System Bytes=4
<B [1] [] '' 01  >
.

2022-12-16 11:38:01,082 Timer::StopT3Timer, SystemBytes=4
2022-12-16 11:38:01,605 Writer#Run Send Primary Message 5
2022-12-16 11:38:01,605 Timer::StartT3Timer, SystemBytes=5
2022-12-16 11:38:01,605 WriteSendMessage: StartT3Timer 5
2022-12-16 11:38:01,605 [SEND] S2F43 W SystemBytes=5
00 00 00 0C 00 00 82 2B 00 00 00 00 00 05 01 00 
2022-12-16 11:38:01,605 [SEND] S2F43 W System Bytes=5
<L [0]
>
.

2022-12-16 11:38:01,740 Timer::StartTimer -8
2022-12-16 11:38:01,740 Timer::StopTimer -8
2022-12-16 11:38:01,740 Read Data: 17 -- 00 00 02 2C 00 00 00 00 00 05 01 02 21 01 00 01 00 
2022-12-16 11:38:01,740 Reader#ByteToBlock Header: 00 00 02 2C 00 00 00 00 00 05 
2022-12-16 11:38:01,740 Reader#ByteToBlock Data: 01 02 21 01 00 01 00 
2022-12-16 11:38:01,740 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:01,755 [RECV] S2F44  System Bytes=5 
2022-12-16 11:38:01,755 [RECV] S2F44 System Bytes=5
<L [2]
    <B [1] [] '' 00  >
    <L [0]
    >
>
.

2022-12-16 11:38:01,755 Timer::StopT3Timer, SystemBytes=5
2022-12-16 11:38:02,279 Writer#Run Send Primary Message 6
2022-12-16 11:38:02,279 Timer::StartT3Timer, SystemBytes=6
2022-12-16 11:38:02,279 WriteSendMessage: StartT3Timer 6
2022-12-16 11:38:02,279 [SEND] S2F37 W SystemBytes=6
00 00 00 11 00 00 82 25 00 00 00 00 00 06 01 02 25 01 00 01 00 
2022-12-16 11:38:02,279 [SEND] S2F37 W System Bytes=6
<L [2]
    <BOOLEAN [1] [CEED]  F >
    <L [0]
    >
>
.

2022-12-16 11:38:02,368 Timer::StartTimer -8
2022-12-16 11:38:02,368 Timer::StopTimer -8
2022-12-16 11:38:02,368 Read Data: 13 -- 00 00 02 26 00 00 00 00 00 06 21 01 00 
2022-12-16 11:38:02,368 Reader#ByteToBlock Header: 00 00 02 26 00 00 00 00 00 06 
2022-12-16 11:38:02,368 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:38:02,368 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:02,383 [RECV] S2F38  System Bytes=6 
2022-12-16 11:38:02,383 [RECV] S2F38 System Bytes=6
<B [1] [] '' 00  >
.

2022-12-16 11:38:02,383 Timer::StopT3Timer, SystemBytes=6
2022-12-16 11:38:02,907 Writer#Run Send Primary Message 7
2022-12-16 11:38:02,907 Timer::StartT3Timer, SystemBytes=7
2022-12-16 11:38:02,907 WriteSendMessage: StartT3Timer 7
2022-12-16 11:38:02,907 [SEND] S2F35 W SystemBytes=7
00 00 00 14 00 00 82 23 00 00 00 00 00 07 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:38:02,907 [SEND] S2F35 W System Bytes=7
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:38:03,027 Timer::StartTimer -8
2022-12-16 11:38:03,027 Timer::StopTimer -8
2022-12-16 11:38:03,027 Read Data: 13 -- 00 00 02 24 00 00 00 00 00 07 21 01 00 
2022-12-16 11:38:03,027 Reader#ByteToBlock Header: 00 00 02 24 00 00 00 00 00 07 
2022-12-16 11:38:03,027 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:38:03,027 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:03,042 [RECV] S2F36  System Bytes=7 
2022-12-16 11:38:03,042 [RECV] S2F36 System Bytes=7
<B [1] [] '' 00  >
.

2022-12-16 11:38:03,042 Timer::StopT3Timer, SystemBytes=7
2022-12-16 11:38:03,565 Writer#Run Send Primary Message 8
2022-12-16 11:38:03,565 Timer::StartT3Timer, SystemBytes=8
2022-12-16 11:38:03,565 WriteSendMessage: StartT3Timer 8
2022-12-16 11:38:03,566 [SEND] S2F33 W SystemBytes=8
00 00 00 14 00 00 82 21 00 00 00 00 00 08 01 02 B1 04 00 00 00 00 01 00 
2022-12-16 11:38:03,566 [SEND] S2F33 W System Bytes=8
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [0]
    >
>
.

2022-12-16 11:38:03,670 Timer::StartTimer -8
2022-12-16 11:38:03,670 Timer::StopTimer -8
2022-12-16 11:38:03,670 Read Data: 13 -- 00 00 02 22 00 00 00 00 00 08 21 01 00 
2022-12-16 11:38:03,670 Reader#ByteToBlock Header: 00 00 02 22 00 00 00 00 00 08 
2022-12-16 11:38:03,670 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:38:03,670 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:03,685 [RECV] S2F34  System Bytes=8 
2022-12-16 11:38:03,685 [RECV] S2F34 System Bytes=8
<B [1] [DRACK] '' 00  >
.

2022-12-16 11:38:03,685 Timer::StopT3Timer, SystemBytes=8
2022-12-16 11:38:04,208 Writer#Run Send Primary Message 9
2022-12-16 11:38:04,208 Timer::StartT3Timer, SystemBytes=9
2022-12-16 11:38:04,208 WriteSendMessage: StartT3Timer 9
2022-12-16 11:38:04,208 [SEND] S5F3 W SystemBytes=9
00 00 00 15 00 00 85 03 00 00 00 00 00 09 01 02 21 01 00 B1 04 00 00 00 00 
2022-12-16 11:38:04,208 [SEND] S5F3 W System Bytes=9
<L [2]
    <B [1] [ALED] '' 00  >
    <U4 [1] [ALID]  0 >
>
.

2022-12-16 11:38:04,313 Timer::StartTimer -8
2022-12-16 11:38:04,313 Timer::StopTimer -8
2022-12-16 11:38:04,313 Read Data: 13 -- 00 00 05 04 00 00 00 00 00 09 21 01 00 
2022-12-16 11:38:04,313 Reader#ByteToBlock Header: 00 00 05 04 00 00 00 00 00 09 
2022-12-16 11:38:04,313 Reader#ByteToBlock Data: 21 01 00 
2022-12-16 11:38:04,313 HSMSPort::OnReadHsms Not control message.
2022-12-16 11:38:04,328 [RECV] S5F4  System Bytes=9 
2022-12-16 11:38:04,328 [RECV] S5F4 System Bytes=9
<B [1] [ACKC5] '' 00  >
.

2022-12-16 11:38:04,328 Timer::StopT3Timer, SystemBytes=9
2022-12-16 11:38:04,868 Writer#Run Send Primary Message 10
2022-12-16 11:38:04,868 Timer::StartT3Timer, SystemBytes=10
2022-12-16 11:38:04,868 WriteSendMessage: StartT3Timer 10
2022-12-16 11:38:04,868 [SEND] S2F33 W SystemBytes=10
00 00 02 18 00 00 82 21 00 00 00 00 00 0A 01 02 B1 04 00 00 00 00 01 0F 01 02 B1 04 00 00 00 01 01 03 B1 04 00 00 4F 4C B1 04 00 00 4F B0 B1 04 00 00 4F B1 01 02 B1 04 00 00 00 0B 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 0C 01 04 B1 04 00 00 4F 4C B1 04 00 00 4E EA B1 04 00 00 4E EB B1 04 00 00 4E EC 01 02 B1 04 00 00 00 15 01 03 B1 04 00 00 4F 4C B1 04 00 00 51 40 B1 04 00 00 51 44 01 02 B1 04 00 00 00 16 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 17 01 02 B1 04 00 00 4F 4C B1 04 00 00 51 40 01 02 B1 04 00 00 00 78 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 00 00 79 01 01 B1 04 00 00 4F 4C 01 02 B1 04 00 03 0D 4B 01 05 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 41 B1 04 00 00 9C 40 B1 04 00 00 9C 42 01 02 B1 04 00 03 0D 4C 01 0D B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 41 B1 04 00 00 9C 42 B1 04 00 00 9C 4A B1 04 00 00 9C 4B B1 04 00 00 9C 4C B1 04 00 00 9C 4D B1 04 00 00 9C 4E B1 04 00 00 9C 4F B1 04 00 00 9C 50 B1 04 00 00 9C 51 01 02 B1 04 00 03 0D 55 01 03 B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 01 02 B1 04 00 03 0D 56 01 0B B1 04 00 00 4F 4C B1 04 00 00 9C 43 B1 04 00 00 9C 40 B1 04 00 00 9C 42 B1 04 00 00 A0 28 B1 04 00 00 A0 2A B1 04 00 00 A0 2B B1 04 00 00 A0 2C B1 04 00 00 A0 2D B1 04 00 00 A0 2E B1 04 00 00 A0 2F 01 02 B1 04 00 03 0D 60 01 02 B1 04 00 00 4F 4C B1 04 00 00 65 90 01 02 B1 04 00 03 0D 69 01 04 B1 04 00 00 4F 4C B1 04 00 00 52 14 B1 04 00 00 52 15 B1 04 00 00 52 16 01 02 B1 04 00 03 0D 7D 01 03 B1 04 00 00 4F 4C B1 04 00 00 52 12 B1 04 00 00 52 13 
2022-12-16 11:38:04,868 [SEND] S2F33 W System Bytes=10
<L [2]
    <U4 [1] [DATAID]  0 >
    <L [15]
        <L [2]
            <U4 [1] [reportid]  1 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentControlState]  20400 >
                <U4 [1] [PreviousControlState]  20401 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  11 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  12 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [AlarmID]  20202 >
                <U4 [1] [AlarmText]  20203 >
                <U4 [1] [AlarmsCategory]  20204 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  21 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
                <U4 [1] [SpoolingState]  20804 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  22 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  23 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SpoolCountActual]  20800 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  120 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  121 >
            <L [1]
                <U4 [1] [Clock]  20300 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200011 >
            <L [5]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200012 >
            <L [13]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [LocationID]  40001 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] [Target A]  40010 >
                <U4 [1] [Target B]  40011 >
                <U4 [1] [Target C]  40012 >
                <U4 [1] [Target D]  40013 >
                <U4 [1] [Reroute A]  40014 >
                <U4 [1] [Reroute B]  40015 >
                <U4 [1] [Reroute C]  40016 >
                <U4 [1] [Reroute D]  40017 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200021 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200022 >
            <L [11]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [StateFlag]  40003 >
                <U4 [1] [SubstrateID]  40000 >
                <U4 [1] [MaterialStatus]  40002 >
                <U4 [1] []  41000 >
                <U4 [1] []  41002 >
                <U4 [1] []  41003 >
                <U4 [1] []  41004 >
                <U4 [1] []  41005 >
                <U4 [1] []  41006 >
                <U4 [1] []  41007 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200032 >
            <L [2]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [SlotList]  26000 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200041 >
            <L [4]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [UserName]  21012 >
                <U4 [1] [PreviousUserName]  21013 >
                <U4 [1] [LoginState]  21014 >
            >
        >
        <L [2]
            <U4 [1] [reportid]  200061 >
            <L [3]
                <U4 [1] [Clock]  20300 >
                <U4 [1] [CurrentEquipmentState]  21010 >
                <U4 [1] [PreviousEquipmentState]  21011 >
            >
        >
    >
>
.

2022-12-16 11:38:50,032 HSMSTimer::CheckT3Timeout: 45.1642412, 10
2022-12-16 11:38:50,032 T3 Timeout: System Bytes=10
2022-12-16 11:38:50,032 Timer#Run: Timeout Message System Bytes=10
2022-12-16 11:38:50,054 SystemBytes: 10, ERRCODE: T3TimeOut, ERRDESC: T3 TimeOut: Reply Timeout..
2022-12-16 11:39:04,872 Timer::StartTimer -8
2022-12-16 11:39:04,873 Timer::StopTimer -8
2022-12-16 11:39:04,873 Read Data: 10 -- FF FF 00 00 00 05 5A 1C 87 72 
2022-12-16 11:39:04,873 Reader#ByteToBlock Header: FF FF 00 00 00 05 5A 1C 87 72 
2022-12-16 11:39:04,873 HSMSPort::OnReadHsms control message.
2022-12-16 11:39:04,873 [RECV] FF FF 00 00 00 05 5A 1C 87 72   LinkTest.Req
2022-12-16 11:39:04,873 [WRITE] [SB:1511819122, 6] 00 00 00 0A FF FF 00 00 00 06 5A 1C 87 72 
2022-12-16 11:39:04,873 [SEND] 00 00 00 0A FF FF 00 00 00 06 5A 1C 87 72   LinkTest.Rsp