8.22.2.14 Double-bit Input Change With Relative Time, 0x08 (revision 2.7, subset level 2)

Device under test: Step Function I/O dnp3 outstation

05:30:06.843 Running procedure: 8.22.2.14
05:30:06.844 This procedure is enabled because the following options:
05:30:06.844 - supports.doubleBitInput == true
05:30:06.844 - supports.doubleBitInputChangeEvents == true
05:30:06.844 - timesync.doubleBitInputChangeWithRelativeTime == true
05:30:06.844 step: 1
05:30:06.844 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:30:06.844 - g4v0, All Objects
05:30:06.844 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:30:06.844 g4v0, All Objects
05:30:06.844 --T-> fir: 1 fin: 1 seq: 0
05:30:06.844 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:30:06.844 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:30:06.844 C0 C1 01 04 00 06 05 23
05:30:06.845 steps: 2 to 3
05:30:06.845 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
05:30:06.845 - If the response carries data, verify that it asks for an application layer confirmation.
05:30:06.845 - Confirm each response that asks for a confirmation
05:30:06.845 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:30:06.845 C0 C1 81 90 00 73 EE
05:30:06.845 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:30:06.845 <-T-- fir: 1 fin: 1 seq: 0
05:30:06.845 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
05:30:06.845 step: 4
05:30:06.845 - Generate 10 Double-bit Binary Input Change Event(s)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_ON, flags=81, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_OFF, flags=41, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_ON, flags=81, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_OFF, flags=41, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_ON, flags=81, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_OFF, flags=41, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.845 [PLG] Updated DBBI 0: value=DETERMINED_ON, flags=81, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.846 [PLG] Updated DBBI 0: value=DETERMINED_OFF, flags=41, timestamp=1793251806845 (UNSYNCHRONIZED_TIME)
05:30:06.846 [PLG] Updated DBBI 0: value=DETERMINED_ON, flags=81, timestamp=1793251806846 (UNSYNCHRONIZED_TIME)
05:30:06.846 [PLG] Updated DBBI 0: value=DETERMINED_OFF, flags=41, timestamp=1793251806846 (UNSYNCHRONIZED_TIME)
05:30:06.846 The plugin reports the DUT's clock unsynchronized
05:30:06.846 step: 5
05:30:06.846 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:30:06.846 - g4v3, 2-Byte Count, count: 1
05:30:06.846 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:30:06.846 g4v3, 2-Byte Count, count: 1
05:30:06.846 --T-> fir: 1 fin: 1 seq: 0
05:30:06.846 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 13 dest: 1024 src: 1
05:30:06.846 --P-> 05 64 0D C4 00 04 01 00 13 E1
05:30:06.846 C0 C2 01 04 03 08 01 00 0A AE
05:30:06.846 steps: 6 to 11
05:30:06.846 - Read a single fragment response w/ sequence(0x02)
05:30:06.846 - Verify the device responds with the first Double-bit Binary event
05:30:06.846 - 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:30:06.846 - Verify that an application layer confirmation is requested.
05:30:06.846 - Verify that the response contains events of the variations List(g4v3), and besides them only CTOs (g51v1 or g51v2, qualifier 0x07)
05:30:06.846 - Verify that the event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:30:06.846 - Verify that each relative-time event is preceded by a CTO object (Table 8-4)
05:30:06.846 - 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:30:06.846 - Confirm each response that asks for a confirmation
05:30:06.846 <-P-- 05 64 1E 44 01 00 00 04 C8 BD
05:30:06.846 C1 E2 81 92 00 33 02 07 01 7D 0E 23 86 A1 01 04 BD D5
05:30:06.846 03 28 01 00 00 00 81 00 00 9A 2A
05:30:06.846 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 30 dest: 1 src: 1024
05:30:06.846 <-T-- fir: 1 fin: 1 seq: 1
05:30:06.846 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime, Class1Events)
05:30:06.846 g51v2, 1-Byte Count, count: 1
05:30:06.847 time: 1793251806845
05:30:06.847 g4v3, 2-Byte Count and Index, count: 1
05:30:06.847 [0] - flags: 0x81 cto: 0
05:30:06.847 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:30:06.847 --T-> fir: 1 fin: 1 seq: 0
05:30:06.847 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:30:06.847 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:30:06.847 C0 C2 00 D6 8D
05:30:06.847 [PLG] Verified first double-bit binary input point event
05:30:06.847 step: 12
05:30:06.847 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:30:06.847 - g4v3, 2-Byte Count, count: 9
05:30:06.847 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:30:06.847 g4v3, 2-Byte Count, count: 9
05:30:06.847 --T-> fir: 1 fin: 1 seq: 0
05:30:06.847 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 13 dest: 1024 src: 1
05:30:06.847 --P-> 05 64 0D C4 00 04 01 00 13 E1
05:30:06.847 C0 C3 01 04 03 08 09 00 FC 9E
05:30:06.847 steps: 13 to 14
05:30:06.847 - Read a single fragment response w/ sequence(0x03)
05:30:06.847 - Verify that the response holds the Double-bit Binary events generated that weren't reported before
05:30:06.847 - 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:30:06.847 - Verify that an application layer confirmation is requested.
05:30:06.847 - Verify that the response contains events of the variations List(g4v3), and besides them only CTOs (g51v1 or g51v2, qualifier 0x07)
05:30:06.847 - Verify that the event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:30:06.847 - Verify that each relative-time event is preceded by a CTO object (Table 8-4)
05:30:06.847 - 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:30:06.847 - Confirm each response that asks for a confirmation
05:30:06.847 <-P-- 05 64 46 44 01 00 00 04 A8 F1
05:30:06.847 C2 E3 81 90 00 33 02 07 01 7D 0E 23 86 A1 01 04 47 D3
05:30:06.847 03 28 09 00 00 00 41 00 00 00 00 81 00 00 00 00 09 E8
05:30:06.847 41 00 00 00 00 81 00 00 00 00 41 00 00 00 00 81 B2 55
05:30:06.847 00 00 00 00 41 00 00 00 00 81 01 00 00 00 41 01 F6 90
05:30:06.847 00 FF FF
05:30:06.847 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 70 dest: 1 src: 1024
05:30:06.847 <-T-- fir: 1 fin: 1 seq: 2
05:30:06.848 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
05:30:06.848 g51v2, 1-Byte Count, count: 1
05:30:06.848 time: 1793251806845
05:30:06.848 g4v3, 2-Byte Count and Index, count: 9
05:30:06.848 [0] - flags: 0x41 cto: 0
05:30:06.848 [0] - flags: 0x81 cto: 0
05:30:06.848 [0] - flags: 0x41 cto: 0
05:30:06.848 [0] - flags: 0x81 cto: 0
05:30:06.848 [0] - flags: 0x41 cto: 0
05:30:06.848 [0] - flags: 0x81 cto: 0
05:30:06.848 [0] - flags: 0x41 cto: 0
05:30:06.848 [0] - flags: 0x81 cto: 1
05:30:06.848 [0] - flags: 0x41 cto: 1
05:30:06.848 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:30:06.848 --T-> fir: 1 fin: 1 seq: 0
05:30:06.848 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:30:06.848 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:30:06.848 C0 C3 00 98 26
05:30:06.848 [PLG] Verified 9 double-bit binary input point event(s)
05:30:06.848 step: 15
05:30:06.848 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:30:06.848 - g4v0, All Objects
05:30:06.848 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:30:06.848 g4v0, All Objects
05:30:06.848 --T-> fir: 1 fin: 1 seq: 0
05:30:06.848 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:30:06.848 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:30:06.848 C0 C4 01 04 00 06 1B 8C
05:30:06.849 step: 16
05:30:06.849 - Read a single fragment response w/ sequence(0x04)
05:30:06.849 - Verify that the response is empty
05:30:06.849 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:30:06.849 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:30:06.849 C3 C4 81 90 00 BA 95
05:30:06.849 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:30:06.849 <-T-- fir: 1 fin: 1 seq: 3
05:30:06.849 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime)
05:30:06.849 Passed procedure: 8.22.2.14