8.14.2o Binary Input Change with Relative Time, Qualifier 0x08 (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

05:28:29.640 Running procedure: 8.14.2o
05:28:29.641 This procedure is enabled because the following options:
05:28:29.641 - supports.binaryInput == true
05:28:29.641 - supports.binaryInputChangeEvents == true
05:28:29.641 - supports.binaryInputEventReads == true
05:28:29.641 - timesync.binaryInputChangeWithRelativeTimeRejected == false
05:28:29.641 step: 1
05:28:29.641 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:28:29.641 - g2v0, All Objects
05:28:29.641 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:28:29.641 g2v0, All Objects
05:28:29.642 --T-> fir: 1 fin: 1 seq: 0
05:28:29.642 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:28:29.642 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:28:29.642 C0 C1 01 02 00 06 95 76
05:28:29.642 steps: 2 to 3
05:28:29.642 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
05:28:29.642 - If the response carries data, verify that it asks for an application layer confirmation.
05:28:29.642 - Confirm each response that asks for a confirmation
05:28:29.642 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:28:29.642 C0 C1 81 90 00 73 EE
05:28:29.642 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:28:29.642 <-T-- fir: 1 fin: 1 seq: 0
05:28:29.642 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
05:28:29.643 step: 4
05:28:29.643 - Generate 10 Binary Input Change Event(s)
05:28:29.643 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.643 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251709643 (UNSYNCHRONIZED_TIME)
05:28:29.644 The plugin reports the DUT's clock unsynchronized
05:28:29.644 step: 5
05:28:29.644 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:28:29.644 - g2v3, 2-Byte Count, count: 1
05:28:29.644 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:28:29.644 g2v3, 2-Byte Count, count: 1
05:28:29.644 --T-> fir: 1 fin: 1 seq: 0
05:28:29.644 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 13 dest: 1024 src: 1
05:28:29.644 --P-> 05 64 0D C4 00 04 01 00 13 E1
05:28:29.644 C0 C2 01 02 03 08 01 00 1E 64
05:28:29.644 steps: 6 to 12
05:28:29.644 - Read a single fragment response w/ sequence(0x02)
05:28:29.644 - Verify the device responds with the first Binary Input event
05:28:29.644 - 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:28:29.644 - Verify that an application layer confirmation is requested.
05:28:29.644 - Verify that the events are reported as 3.1r1's rules for event reporting require, for a read of g2v3, by the state of the DUT's clock when it recorded them, where the procedure or the plugin knows it
05:28:29.644 - 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:28:29.644 - Confirm each response that asks for a confirmation
05:28:29.644 <-P-- 05 64 1E 44 01 00 00 04 C8 BD
05:28:29.644 C1 E2 81 92 00 33 02 07 01 CB 92 21 86 A1 01 02 CA E3
05:28:29.644 03 28 01 00 00 00 81 00 00 9A 2A
05:28:29.644 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 30 dest: 1 src: 1024
05:28:29.644 <-T-- fir: 1 fin: 1 seq: 1
05:28:29.644 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime, Class1Events)
05:28:29.644 g51v2, 1-Byte Count, count: 1
05:28:29.644 time: 1793251709643
05:28:29.644 g2v3, 2-Byte Count and Index, count: 1
05:28:29.644 [0] - flags: 0x81 cto: 0
05:28:29.644 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:28:29.644 --T-> fir: 1 fin: 1 seq: 0
05:28:29.644 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:28:29.644 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:28:29.644 C0 C2 00 D6 8D
05:28:29.645 [PLG] Verified first binary input point event
05:28:29.645 step: 13
05:28:29.645 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:28:29.645 - g2v3, 2-Byte Count, count: 9
05:28:29.645 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:28:29.645 g2v3, 2-Byte Count, count: 9
05:28:29.645 --T-> fir: 1 fin: 1 seq: 0
05:28:29.645 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 13 dest: 1024 src: 1
05:28:29.645 --P-> 05 64 0D C4 00 04 01 00 13 E1
05:28:29.645 C0 C3 01 02 03 08 09 00 E8 54
05:28:29.645 steps: 14 to 16
05:28:29.645 - Read a single fragment response w/ sequence(0x03)
05:28:29.645 - Verify that the response holds the Binary Input events generated that weren't reported before
05:28:29.645 - 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:28:29.645 - Verify that an application layer confirmation is requested.
05:28:29.645 - Verify that the events are reported as 3.1r1's rules for event reporting require, for a read of g2v3, by the state of the DUT's clock when it recorded them, where the procedure or the plugin knows it
05:28:29.645 - 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:28:29.645 - Confirm each response that asks for a confirmation
05:28:29.645 <-P-- 05 64 46 44 01 00 00 04 A8 F1
05:28:29.645 C2 E3 81 90 00 33 02 07 01 CB 92 21 86 A1 01 02 30 E5
05:28:29.645 03 28 09 00 00 00 01 00 00 00 00 81 00 00 00 00 E7 8C
05:28:29.645 01 00 00 00 00 81 00 00 00 00 01 00 00 00 00 81 49 E0
05:28:29.645 00 00 00 00 01 00 00 00 00 81 00 00 00 00 01 00 7B 1B
05:28:29.645 00 FF FF
05:28:29.645 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 70 dest: 1 src: 1024
05:28:29.645 <-T-- fir: 1 fin: 1 seq: 2
05:28:29.646 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
05:28:29.646 g51v2, 1-Byte Count, count: 1
05:28:29.646 time: 1793251709643
05:28:29.646 g2v3, 2-Byte Count and Index, count: 9
05:28:29.646 [0] - flags: 0x01 cto: 0
05:28:29.646 [0] - flags: 0x81 cto: 0
05:28:29.646 [0] - flags: 0x01 cto: 0
05:28:29.646 [0] - flags: 0x81 cto: 0
05:28:29.646 [0] - flags: 0x01 cto: 0
05:28:29.646 [0] - flags: 0x81 cto: 0
05:28:29.646 [0] - flags: 0x01 cto: 0
05:28:29.646 [0] - flags: 0x81 cto: 0
05:28:29.646 [0] - flags: 0x01 cto: 0
05:28:29.646 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:28:29.646 --T-> fir: 1 fin: 1 seq: 0
05:28:29.646 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:28:29.646 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:28:29.646 C0 C3 00 98 26
05:28:29.646 [PLG] Verified 9 binary input point event(s)
05:28:29.646 step: 17
05:28:29.646 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:28:29.646 - g2v0, All Objects
05:28:29.646 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:28:29.646 g2v0, All Objects
05:28:29.646 --T-> fir: 1 fin: 1 seq: 0
05:28:29.646 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:28:29.646 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:28:29.646 C0 C4 01 02 00 06 8B D9
05:28:29.646 step: 18
05:28:29.646 - Read a single fragment response w/ sequence(0x04)
05:28:29.646 - Verify that the response is empty
05:28:29.646 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:28:29.646 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:28:29.646 C3 C4 81 90 00 BA 95
05:28:29.646 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:28:29.646 <-T-- fir: 1 fin: 1 seq: 3
05:28:29.646 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime)
05:28:29.646 Passed procedure: 8.14.2o