8.15.2 Test Procedure (revision 2.7, subset level 2)

Device under test: Step Function I/O dnp3 outstation

05:29:22.083 Running procedure: 8.15.2
05:29:22.085 This procedure is enabled because the following options:
05:29:22.085 - supports.binaryInput == true
05:29:22.085 - supports.binaryInputChangeEvents == true
05:29:22.085 - timesync.binaryInputChangeWithRelativeTime == true
05:29:22.085 step: 1
05:29:22.085 - DUT supports Binary Input Change with Relative Time.
05:29:22.085 step: 2
05:29:22.085 - Cycle power to the DUT
05:29:22.085 [PLG] Cycling power
05:29:22.086 step: 3
05:29:22.086 - Write(0x02) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:29:22.086 - g80v1, 1-Byte Start/Stop, start: 7 stop: 7
05:29:22.086 - [7] - BooleanValue(false)
05:29:22.086 - Read a single fragment response w/ sequence(0x00)
05:29:22.086 - Verify that the response is empty
05:29:22.086 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:29:22.086 --A-> Write(0x02) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:29:22.086 g80v1, 1-Byte Start/Stop, start: 7 stop: 7
05:29:22.086 [7] - BooleanValue(false)
05:29:22.086 --T-> fir: 1 fin: 1 seq: 0
05:29:22.086 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 14 dest: 1024 src: 1
05:29:22.086 --P-> 05 64 0E C4 00 04 01 00 43 72
05:29:22.086 C0 C0 02 50 01 00 07 07 00 2C 49
05:29:22.087 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:29:22.087 C0 C0 81 10 00 B4 37
05:29:22.087 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:29:22.087 <-T-- fir: 1 fin: 1 seq: 0
05:29:22.087 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(NeedTime)
05:29:22.087 step: 4
05:29:22.087 - Change binary inputs several times, one or more of them, to create events
05:29:22.087 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 1: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 2: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 3: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 4: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 5: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 6: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.087 [PLG] Updated BI 7: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.088 [PLG] Updated BI 8: value=true, flags=81, timestamp=1793251762087 (UNSYNCHRONIZED_TIME)
05:29:22.088 [PLG] Updated BI 9: value=true, flags=81, timestamp=1793251762088 (UNSYNCHRONIZED_TIME)
05:29:22.088 The plugin reports the DUT's clock unsynchronized
05:29:22.088 step: 5
05:29:22.088 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:29:22.088 - g2v3, All Objects
05:29:22.088 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:29:22.088 g2v3, All Objects
05:29:22.088 --T-> fir: 1 fin: 1 seq: 0
05:29:22.088 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:22.088 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:22.088 C0 C1 01 02 03 06 3E C6
05:29:22.088 steps: 6 to 9
05:29:22.088 - Read a single fragment response w/ sequence(0x01)
05:29:22.088 - Verify that the response contains events of the variations List(g2v3), and besides them only CTOs (g51v2, qualifier 0x07)
05:29:22.088 - Verify that the event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:29:22.088 - Verify that each relative-time event is preceded by a CTO object (Table 8-4)
05:29:22.088 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
05:29:22.088 - Verify that an application layer confirmation is requested.
05:29:22.088 - Verify that the response holds every Binary Input event generated
05:29:22.088 - If the events carry timestamps, verify that the gaps between them match the gaps between when the events were generated, to the Device Profile's resolution
05:29:22.088 - Confirm each response that asks for a confirmation
05:29:22.088 <-P-- 05 64 4B 44 01 00 00 04 FD 93
05:29:22.088 C1 E1 81 10 00 33 02 07 01 A7 5F 22 86 A1 01 02 83 C4
05:29:22.088 03 28 0A 00 00 00 81 00 00 01 00 81 00 00 02 00 AC 42
05:29:22.088 81 00 00 03 00 81 00 00 04 00 81 00 00 05 00 81 9B 00
05:29:22.088 00 00 06 00 81 00 00 07 00 81 00 00 08 00 81 00 A9 FA
05:29:22.088 00 09 00 81 01 00 E1 6E
05:29:22.088 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 75 dest: 1 src: 1024
05:29:22.088 <-T-- fir: 1 fin: 1 seq: 1
05:29:22.088 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x01 IIN(NeedTime)
05:29:22.088 g51v2, 1-Byte Count, count: 1
05:29:22.088 time: 1793251762087
05:29:22.088 g2v3, 2-Byte Count and Index, count: 10
05:29:22.088 [0] - flags: 0x81 cto: 0
05:29:22.088 [1] - flags: 0x81 cto: 0
05:29:22.088 [2] - flags: 0x81 cto: 0
05:29:22.088 [3] - flags: 0x81 cto: 0
05:29:22.088 [4] - flags: 0x81 cto: 0
05:29:22.088 [5] - flags: 0x81 cto: 0
05:29:22.088 [6] - flags: 0x81 cto: 0
05:29:22.088 [7] - flags: 0x81 cto: 0
05:29:22.088 [8] - flags: 0x81 cto: 0
05:29:22.088 [9] - flags: 0x81 cto: 1
05:29:22.088 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:29:22.088 --T-> fir: 1 fin: 1 seq: 0
05:29:22.088 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:22.088 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:22.088 C0 C1 00 7D 3D
05:29:22.089 [PLG] Verified 10 binary input point event(s)
05:29:22.089 step: 10
05:29:22.089 - Device supports time synchronization from DNP3 master
05:29:22.089 step: 11
05:29:22.089 - Wait for 5000 milliseconds
05:29:27.089 step: 12
05:29:27.089 - Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:29:27.089 --A-> Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:29:27.089 --T-> fir: 1 fin: 1 seq: 0
05:29:27.089 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:27.089 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:27.089 C0 C2 17 27 BC
05:29:27.090 step: 13
05:29:27.090 - Read a single fragment response w/ sequence(0x02)
05:29:27.090 - Verify that the response is one g52v2 object (qualifier 0x07, count 1) carrying the measured delay in milliseconds
05:29:27.090 - Verify that the IIN field contains IIN(NeedTime)
05:29:27.090 <-P-- 05 64 10 44 01 00 00 04 CD 4C
05:29:27.090 C2 C2 81 10 00 34 02 07 01 00 00 DB F7
05:29:27.090 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 16 dest: 1 src: 1024
05:29:27.090 <-T-- fir: 1 fin: 1 seq: 2
05:29:27.090 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02 IIN(NeedTime)
05:29:27.090 g52v2, 1-Byte Count, count: 1
05:29:27.090 delay: 0
05:29:27.090 step: 14
05:29:27.090 - Write the current time + 0 ms w/ sequence(0x03)
05:29:27.090 --A-> Write(0x02) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:29:27.090 g50v1, 1-Byte Count, count: 1
05:29:27.090 time: 1793251767090
05:29:27.090 --T-> fir: 1 fin: 1 seq: 0
05:29:27.090 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 18 dest: 1024 src: 1
05:29:27.091 --P-> 05 64 12 C4 00 04 01 00 30 DD
05:29:27.091 C0 C3 02 32 01 07 01 32 73 22 86 A1 01 5B 4F
05:29:27.091 step: 15
05:29:27.091 - Read a single fragment response w/ sequence(0x03)
05:29:27.091 - Verify that the response is empty
05:29:27.091 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:29:27.091 - Verify that the IIN field does not contain bits IIN(NeedTime)
05:29:27.092 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:29:27.092 C3 C3 81 00 00 D7 87
05:29:27.092 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:29:27.092 <-T-- fir: 1 fin: 1 seq: 3
05:29:27.092 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03 IIN()
05:29:27.092 step: 16
05:29:27.092 - Change binary inputs several times, one or more of them, to create events
05:29:27.092 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 1: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 2: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 3: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 4: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 5: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 6: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 7: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 8: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 [PLG] Updated BI 9: value=false, flags=1, timestamp=1793251767091 (SYNCHRONIZED_TIME)
05:29:27.092 The plugin reports the DUT's clock synchronized
05:29:27.092 step: 17
05:29:27.092 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:29:27.092 - g2v3, All Objects
05:29:27.092 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:29:27.092 g2v3, All Objects
05:29:27.092 --T-> fir: 1 fin: 1 seq: 0
05:29:27.092 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:27.092 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:27.092 C0 C4 01 02 03 06 20 69
05:29:27.092 steps: 18 to 21
05:29:27.092 - Read a single fragment response w/ sequence(0x04)
05:29:27.092 - Verify that the response contains events of the variations List(g2v3), and besides them only CTOs (g51v1, qualifier 0x07)
05:29:27.092 - Verify that the event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:29:27.092 - Verify that each relative-time event is preceded by a CTO object (Table 8-4)
05:29:27.092 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
05:29:27.092 - Verify that an application layer confirmation is requested.
05:29:27.092 - Verify that the response holds every Binary Input event generated
05:29:27.092 - If the events carry timestamps, verify that the gaps between them match the gaps between when the events were generated, to the Device Profile's resolution
05:29:27.092 - Confirm each response that asks for a confirmation
05:29:27.093 <-P-- 05 64 4B 44 01 00 00 04 FD 93
05:29:27.093 C4 E4 81 00 00 33 01 07 01 33 73 22 86 A1 01 02 86 8E
05:29:27.093 03 28 0A 00 00 00 01 00 00 01 00 01 00 00 02 00 04 EA
05:29:27.093 01 00 00 03 00 01 00 00 04 00 01 00 00 05 00 01 19 E1
05:29:27.093 00 00 06 00 01 00 00 07 00 01 00 00 08 00 01 00 8E 16
05:29:27.093 00 09 00 01 00 00 08 90
05:29:27.093 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 75 dest: 1 src: 1024
05:29:27.093 <-T-- fir: 1 fin: 1 seq: 4
05:29:27.093 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x04 IIN()
05:29:27.093 g51v1, 1-Byte Count, count: 1
05:29:27.093 time: 1793251767091
05:29:27.093 g2v3, 2-Byte Count and Index, count: 10
05:29:27.093 [0] - flags: 0x01 cto: 0
05:29:27.093 [1] - flags: 0x01 cto: 0
05:29:27.093 [2] - flags: 0x01 cto: 0
05:29:27.093 [3] - flags: 0x01 cto: 0
05:29:27.093 [4] - flags: 0x01 cto: 0
05:29:27.093 [5] - flags: 0x01 cto: 0
05:29:27.093 [6] - flags: 0x01 cto: 0
05:29:27.093 [7] - flags: 0x01 cto: 0
05:29:27.093 [8] - flags: 0x01 cto: 0
05:29:27.093 [9] - flags: 0x01 cto: 0
05:29:27.093 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:29:27.093 --T-> fir: 1 fin: 1 seq: 0
05:29:27.093 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:27.093 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:27.093 C0 C4 00 F9 A1
05:29:27.093 [PLG] Verified 10 binary input point event(s)
05:29:27.093 step: 22
05:29:27.093 - Change binary inputs several times, one or more of them, to create events
05:29:27.093 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.093 [PLG] Updated BI 1: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.093 [PLG] Updated BI 2: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.093 [PLG] Updated BI 3: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.094 [PLG] Updated BI 4: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.094 [PLG] Updated BI 5: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.094 [PLG] Updated BI 6: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.094 [PLG] Updated BI 7: value=true, flags=81, timestamp=1793251767092 (SYNCHRONIZED_TIME)
05:29:27.094 [PLG] Updated BI 8: value=true, flags=81, timestamp=1793251767093 (SYNCHRONIZED_TIME)
05:29:27.094 [PLG] Updated BI 9: value=true, flags=81, timestamp=1793251767093 (SYNCHRONIZED_TIME)
05:29:27.094 The plugin reports the DUT's clock synchronized
05:29:27.094 step: 23
05:29:27.094 - Wait for 5000 milliseconds
05:29:32.094 step: 24
05:29:32.094 - Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
05:29:32.094 --A-> Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
05:29:32.094 --T-> fir: 1 fin: 1 seq: 0
05:29:32.094 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:32.094 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:32.094 C0 C5 17 46 3B
05:29:32.094 step: 25
05:29:32.094 - Read a single fragment response w/ sequence(0x05)
05:29:32.094 - Verify that the response is one g52v2 object (qualifier 0x07, count 1) carrying the measured delay in milliseconds
05:29:32.094 - Verify that the IIN field contains IIN(NeedTime)
05:29:32.094 <-P-- 05 64 10 44 01 00 00 04 CD 4C
05:29:32.094 C5 C5 81 12 00 34 02 07 01 00 00 89 68
05:29:32.094 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 16 dest: 1 src: 1024
05:29:32.094 <-T-- fir: 1 fin: 1 seq: 5
05:29:32.095 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05 IIN(NeedTime, Class1Events)
05:29:32.095 g52v2, 1-Byte Count, count: 1
05:29:32.095 delay: 0
05:29:32.095 step: 26
05:29:32.095 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x06
05:29:32.095 - g2v3, All Objects
05:29:32.095 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x06
05:29:32.095 g2v3, All Objects
05:29:32.095 --T-> fir: 1 fin: 1 seq: 0
05:29:32.095 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:32.095 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:32.095 C0 C6 01 02 03 06 2C 2F
05:29:32.095 steps: 27 to 29
05:29:32.095 - Read a single fragment response w/ sequence(0x06)
05:29:32.095 - Verify that the response contains events of the variations List(g2v3), and besides them only CTOs (g51v1, qualifier 0x07)
05:29:32.095 - Verify that the event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:29:32.095 - Verify that each relative-time event is preceded by a CTO object (Table 8-4)
05:29:32.095 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
05:29:32.095 - Verify that an application layer confirmation is requested.
05:29:32.095 - Verify that the response holds every Binary Input event generated
05:29:32.095 - If the events carry timestamps, verify that the gaps between them match the gaps between when the events were generated, to the Device Profile's resolution
05:29:32.095 <-P-- 05 64 4B 44 01 00 00 04 FD 93
05:29:32.095 C6 E6 81 10 00 33 01 07 01 34 73 22 86 A1 01 02 AD DE
05:29:32.095 03 28 0A 00 00 00 81 00 00 01 00 81 00 00 02 00 AC 42
05:29:32.095 81 00 00 03 00 81 00 00 04 00 81 00 00 05 00 81 9B 00
05:29:32.095 00 00 06 00 81 00 00 07 00 81 00 00 08 00 81 01 F7 CC
05:29:32.095 00 09 00 81 01 00 E1 6E
05:29:32.095 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 75 dest: 1 src: 1024
05:29:32.095 <-T-- fir: 1 fin: 1 seq: 6
05:29:32.096 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x06 IIN(NeedTime)
05:29:32.096 g51v1, 1-Byte Count, count: 1
05:29:32.096 time: 1793251767092
05:29:32.096 g2v3, 2-Byte Count and Index, count: 10
05:29:32.096 [0] - flags: 0x81 cto: 0
05:29:32.096 [1] - flags: 0x81 cto: 0
05:29:32.096 [2] - flags: 0x81 cto: 0
05:29:32.096 [3] - flags: 0x81 cto: 0
05:29:32.096 [4] - flags: 0x81 cto: 0
05:29:32.096 [5] - flags: 0x81 cto: 0
05:29:32.096 [6] - flags: 0x81 cto: 0
05:29:32.096 [7] - flags: 0x81 cto: 0
05:29:32.096 [8] - flags: 0x81 cto: 1
05:29:32.096 [9] - flags: 0x81 cto: 1
05:29:32.096 [PLG] Verified 10 binary input point event(s)
05:29:32.096 step: 30
05:29:32.096 - Withhold the application layer confirmation
05:29:32.096 step: 31
05:29:32.096 - Write the current time + 0 ms w/ sequence(0x07)
05:29:32.096 --A-> Write(0x02) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x07
05:29:32.096 g50v1, 1-Byte Count, count: 1
05:29:32.096 time: 1793251772096
05:29:32.096 --T-> fir: 1 fin: 1 seq: 0
05:29:32.096 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 18 dest: 1024 src: 1
05:29:32.096 --P-> 05 64 12 C4 00 04 01 00 30 DD
05:29:32.096 C0 C7 02 32 01 07 01 C0 86 22 86 A1 01 59 77
05:29:32.096 step: 32
05:29:32.096 - Read a single fragment response w/ sequence(0x07)
05:29:32.096 - Verify that the response is empty
05:29:32.096 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:29:32.096 - Verify that the IIN field does not contain bits IIN(NeedTime)
05:29:32.097 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:29:32.097 C7 C7 81 02 00 01 CC
05:29:32.097 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:29:32.097 <-T-- fir: 1 fin: 1 seq: 7
05:29:32.097 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x07 IIN(Class1Events)
05:29:32.097 step: 33
05:29:32.097 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x08
05:29:32.097 - g2v3, All Objects
05:29:32.097 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x08
05:29:32.097 g2v3, All Objects
05:29:32.097 --T-> fir: 1 fin: 1 seq: 0
05:29:32.097 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:32.097 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:32.097 C0 C8 01 02 03 06 71 B0
05:29:32.097 steps: 34 to 36
05:29:32.097 - Read a single fragment response w/ sequence(0x08)
05:29:32.097 - Verify that the response contains events of the variations List(g2v3), and besides them only CTOs (g51v1, qualifier 0x07)
05:29:32.097 - Verify that the event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:29:32.097 - Verify that each relative-time event is preceded by a CTO object (Table 8-4)
05:29:32.097 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
05:29:32.097 - Verify that an application layer confirmation is requested.
05:29:32.097 - Verify that the response holds every Binary Input event generated
05:29:32.097 - If the events carry timestamps, verify that the gaps between them match the gaps between when the events were generated, to the Device Profile's resolution
05:29:32.097 - Confirm each response that asks for a confirmation
05:29:32.097 <-P-- 05 64 4B 44 01 00 00 04 FD 93
05:29:32.097 C8 E8 81 00 00 33 01 07 01 34 73 22 86 A1 01 02 58 80
05:29:32.097 03 28 0A 00 00 00 81 00 00 01 00 81 00 00 02 00 AC 42
05:29:32.097 81 00 00 03 00 81 00 00 04 00 81 00 00 05 00 81 9B 00
05:29:32.097 00 00 06 00 81 00 00 07 00 81 00 00 08 00 81 01 F7 CC
05:29:32.097 00 09 00 81 01 00 E1 6E
05:29:32.097 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 75 dest: 1 src: 1024
05:29:32.097 <-T-- fir: 1 fin: 1 seq: 8
05:29:32.098 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x08 IIN()
05:29:32.098 g51v1, 1-Byte Count, count: 1
05:29:32.098 time: 1793251767092
05:29:32.098 g2v3, 2-Byte Count and Index, count: 10
05:29:32.098 [0] - flags: 0x81 cto: 0
05:29:32.098 [1] - flags: 0x81 cto: 0
05:29:32.098 [2] - flags: 0x81 cto: 0
05:29:32.098 [3] - flags: 0x81 cto: 0
05:29:32.098 [4] - flags: 0x81 cto: 0
05:29:32.098 [5] - flags: 0x81 cto: 0
05:29:32.098 [6] - flags: 0x81 cto: 0
05:29:32.098 [7] - flags: 0x81 cto: 0
05:29:32.098 [8] - flags: 0x81 cto: 1
05:29:32.098 [9] - flags: 0x81 cto: 1
05:29:32.098 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x08
05:29:32.098 --T-> fir: 1 fin: 1 seq: 0
05:29:32.098 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:32.098 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:32.098 C0 C8 00 A7 F9
05:29:32.098 [PLG] Verified 10 binary input point event(s)
05:29:32.098 step: 37
05:29:32.098 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x09
05:29:32.098 - g2v3, All Objects
05:29:32.098 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x09
05:29:32.098 g2v3, All Objects
05:29:32.098 --T-> fir: 1 fin: 1 seq: 0
05:29:32.098 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:32.098 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:32.098 C0 C9 01 02 03 06 77 93
05:29:32.098 step: 38
05:29:32.098 - Read a single fragment response w/ sequence(0x09)
05:29:32.098 - Verify that the response is empty
05:29:32.098 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:29:32.099 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:29:32.099 C9 C9 81 00 00 14 A9
05:29:32.099 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:29:32.099 <-T-- fir: 1 fin: 1 seq: 9
05:29:32.099 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x09 IIN()
05:29:32.099 Passed procedure: 8.15.2