8.14.2.11 Binary Input Change With Time, 0x08 (revision 2.7, subset level 2)

Device under test: Step Function I/O dnp3 outstation

10:59:46.275 Running procedure: 8.14.2.11
10:59:46.276 This procedure is enabled because the following options:
10:59:46.276 - supports.binaryInput == true
10:59:46.276 - supports.binaryInputChangeEvents == true
10:59:46.276 - timesync.binaryInputChangeWithTime == true
10:59:46.276 step: 1
10:59:46.276 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:59:46.276 - g2v0, All Objects
10:59:46.276 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:59:46.276 g2v0, All Objects
10:59:46.276 --T-> fir: 1 fin: 1 seq: 0
10:59:46.276 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
10:59:46.276 --P-> 05 64 0B C4 00 04 01 00 CA 8A
10:59:46.276 C0 C1 01 02 00 06 95 76
10:59:46.276 steps: 2 to 3
10:59:46.276 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
10:59:46.276 - If the response carries data, verify that it asks for an application layer confirmation.
10:59:46.276 - Confirm each response that asks for a confirmation
10:59:46.276 <-P-- 05 64 0A 44 01 00 00 04 67 88
10:59:46.276 C0 C1 81 90 00 73 EE
10:59:46.276 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
10:59:46.276 <-T-- fir: 1 fin: 1 seq: 0
10:59:46.276 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
10:59:46.277 step: 4
10:59:46.277 - Generate 10 Binary Input Change Event(s)
10:59:46.277 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793185186277 (UNSYNCHRONIZED_TIME)
10:59:46.277 The plugin reports the DUT's clock unsynchronized
10:59:46.277 step: 5
10:59:46.277 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
10:59:46.277 - g2v2, 2-Byte Count, count: 1
10:59:46.277 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
10:59:46.277 g2v2, 2-Byte Count, count: 1
10:59:46.277 --T-> fir: 1 fin: 1 seq: 0
10:59:46.277 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 13 dest: 1024 src: 1
10:59:46.277 --P-> 05 64 0D C4 00 04 01 00 13 E1
10:59:46.277 C0 C2 01 02 02 08 01 00 F6 A6
10:59:46.277 steps: 6 to 11
10:59:46.277 - Read a single fragment response w/ sequence(0x02)
10:59:46.277 - Verify the device responds with the first Binary Input event
10:59:46.277 - 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
10:59:46.277 - Verify that an application layer confirmation is requested.
10:59:46.277 - Verify that the events are reported as TB2017-003a 5.1.3.1.2 requires, which the DUT implements: g2v2 for events recorded while the clock was synchronized, g2v3 after g51v2 for those recorded while it was unsynchronized, by the clock's state as the plugin reports it
10:59:46.277 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
10:59:46.277 - Confirm each response that asks for a confirmation
10:59:46.278 <-P-- 05 64 1E 44 01 00 00 04 C8 BD
10:59:46.278 C1 E2 81 92 00 33 02 07 01 E5 81 2A 82 A1 01 02 15 C1
10:59:46.278 03 28 01 00 00 00 81 00 00 9A 2A
10:59:46.278 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 30 dest: 1 src: 1024
10:59:46.278 <-T-- fir: 1 fin: 1 seq: 1
10:59:46.278 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime, Class1Events)
10:59:46.278 g51v2, 1-Byte Count, count: 1
10:59:46.278 time: 1793185186277
10:59:46.278 g2v3, 2-Byte Count and Index, count: 1
10:59:46.278 [0] - flags: 0x81 cto: 0
10:59:46.278 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
10:59:46.278 --T-> fir: 1 fin: 1 seq: 0
10:59:46.278 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
10:59:46.278 --P-> 05 64 08 C4 00 04 01 00 9A 19
10:59:46.278 C0 C2 00 D6 8D
10:59:46.278 [PLG] Verified first binary input point event
10:59:46.278 Note on the result: The events were checked as TB2017-003a 5.1.3.1.2 requires, which the DUT implements, in place of the steps' g2v2 only
10:59:46.278 step: 12
10:59:46.278 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
10:59:46.278 - g2v2, 2-Byte Count, count: 9
10:59:46.278 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
10:59:46.278 g2v2, 2-Byte Count, count: 9
10:59:46.278 --T-> fir: 1 fin: 1 seq: 0
10:59:46.278 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 13 dest: 1024 src: 1
10:59:46.278 --P-> 05 64 0D C4 00 04 01 00 13 E1
10:59:46.278 C0 C3 01 02 02 08 09 00 00 96
10:59:46.279 steps: 13 to 15
10:59:46.279 - Read a single fragment response w/ sequence(0x03)
10:59:46.279 - Verify that the response holds the Binary Input events generated that weren't reported before
10:59:46.279 - 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
10:59:46.279 - Verify that an application layer confirmation is requested.
10:59:46.279 - Verify that the events are reported as TB2017-003a 5.1.3.1.2 requires, which the DUT implements: g2v2 for events recorded while the clock was synchronized, g2v3 after g51v2 for those recorded while it was unsynchronized, by the clock's state as the plugin reports it
10:59:46.279 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
10:59:46.279 - Confirm each response that asks for a confirmation
10:59:46.279 <-P-- 05 64 46 44 01 00 00 04 A8 F1
10:59:46.279 C2 E3 81 90 00 33 02 07 01 E5 81 2A 82 A1 01 02 EF C7
10:59:46.279 03 28 09 00 00 00 01 00 00 00 00 81 00 00 00 00 E7 8C
10:59:46.279 01 00 00 00 00 81 00 00 00 00 01 00 00 00 00 81 49 E0
10:59:46.279 00 00 00 00 01 00 00 00 00 81 00 00 00 00 01 00 7B 1B
10:59:46.279 00 FF FF
10:59:46.279 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 70 dest: 1 src: 1024
10:59:46.279 <-T-- fir: 1 fin: 1 seq: 2
10:59:46.279 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
10:59:46.279 g51v2, 1-Byte Count, count: 1
10:59:46.279 time: 1793185186277
10:59:46.279 g2v3, 2-Byte Count and Index, count: 9
10:59:46.279 [0] - flags: 0x01 cto: 0
10:59:46.279 [0] - flags: 0x81 cto: 0
10:59:46.279 [0] - flags: 0x01 cto: 0
10:59:46.279 [0] - flags: 0x81 cto: 0
10:59:46.279 [0] - flags: 0x01 cto: 0
10:59:46.279 [0] - flags: 0x81 cto: 0
10:59:46.279 [0] - flags: 0x01 cto: 0
10:59:46.279 [0] - flags: 0x81 cto: 0
10:59:46.279 [0] - flags: 0x01 cto: 0
10:59:46.279 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
10:59:46.279 --T-> fir: 1 fin: 1 seq: 0
10:59:46.279 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
10:59:46.279 --P-> 05 64 08 C4 00 04 01 00 9A 19
10:59:46.279 C0 C3 00 98 26
10:59:46.279 [PLG] Verified 9 binary input point event(s)
10:59:46.279 step: 16
10:59:46.279 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
10:59:46.279 - g2v0, All Objects
10:59:46.279 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
10:59:46.279 g2v0, All Objects
10:59:46.279 --T-> fir: 1 fin: 1 seq: 0
10:59:46.279 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
10:59:46.280 --P-> 05 64 0B C4 00 04 01 00 CA 8A
10:59:46.280 C0 C4 01 02 00 06 8B D9
10:59:46.280 step: 17
10:59:46.280 - Read a single fragment response w/ sequence(0x04)
10:59:46.280 - Verify that the response is empty
10:59:46.280 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
10:59:46.280 <-P-- 05 64 0A 44 01 00 00 04 67 88
10:59:46.280 C3 C4 81 90 00 BA 95
10:59:46.280 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
10:59:46.280 <-T-- fir: 1 fin: 1 seq: 3
10:59:46.280 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime)
10:59:46.280 Passed procedure: 8.14.2.11