8.22f Double-bit Input Change Without Confirm (as 8.14.2f) (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

11:02:05.333 Running procedure: 8.22f
11:02:05.334 This procedure is enabled because the following options:
11:02:05.334 - supports.doubleBitInput == true
11:02:05.334 - supports.doubleBitInputChangeEvents == true
11:02:05.334 - supports.doubleBitInputEventReads == true
11:02:05.334 step: 1
11:02:05.334 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
11:02:05.334 - g4v0, All Objects
11:02:05.334 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
11:02:05.334 g4v0, All Objects
11:02:05.334 --T-> fir: 1 fin: 1 seq: 0
11:02:05.334 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:02:05.334 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:02:05.334 C0 C1 01 04 00 06 05 23
11:02:05.334 steps: 2 to 3
11:02:05.334 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
11:02:05.334 - If the response carries data, verify that it asks for an application layer confirmation.
11:02:05.334 - Confirm each response that asks for a confirmation
11:02:05.335 <-P-- 05 64 0A 44 01 00 00 04 67 88
11:02:05.335 C0 C1 81 90 00 73 EE
11:02:05.335 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
11:02:05.335 <-T-- fir: 1 fin: 1 seq: 0
11:02:05.335 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
11:02:05.335 step: 4
11:02:05.335 - Change double-bit binary inputs several times, one or more of them, to create events
11:02:05.335 [PLG] Updated DBBI 0: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 1: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 2: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 3: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 4: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 5: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 6: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 7: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 8: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 [PLG] Updated DBBI 9: value=DETERMINED_ON, flags=81, timestamp=1793185325335 (UNSYNCHRONIZED_TIME)
11:02:05.335 The plugin reports the DUT's clock unsynchronized
11:02:05.335 step: 5
11:02:05.335 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
11:02:05.335 - g4v0, All Objects
11:02:05.335 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
11:02:05.335 g4v0, All Objects
11:02:05.335 --T-> fir: 1 fin: 1 seq: 0
11:02:05.336 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:02:05.336 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:02:05.336 C0 C2 01 04 00 06 0F 46
11:02:05.336 steps: 6 to 10
11:02:05.336 - Read a single fragment response w/ sequence(0x02)
11:02:05.336 - Verify that the response holds every Double-bit Binary event generated
11:02:05.336 - 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
11:02:05.336 - Verify that an application layer confirmation is requested.
11:02:05.336 - Verify that the events are reported as 3.1r1's rules for event reporting require, for a read of g4v0, by the state of the DUT's clock when it recorded them, where the procedure or the plugin knows it
11:02:05.336 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
11:02:05.336 - Keep the response's objects, to compare the next read's with
11:02:05.336 <-P-- 05 64 2D 44 01 00 00 04 DB A7
11:02:05.336 C1 E2 81 90 00 04 01 28 0A 00 00 00 81 01 00 81 E2 F3
11:02:05.336 02 00 81 03 00 81 04 00 81 05 00 81 06 00 81 07 7C AC
11:02:05.336 00 81 08 00 81 09 00 81 A0 4C
11:02:05.336 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 45 dest: 1 src: 1024
11:02:05.336 <-T-- fir: 1 fin: 1 seq: 1
11:02:05.336 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
11:02:05.336 g4v1, 2-Byte Count and Index, count: 10
11:02:05.336 [0] - flags: 0x81
11:02:05.336 [1] - flags: 0x81
11:02:05.336 [2] - flags: 0x81
11:02:05.336 [3] - flags: 0x81
11:02:05.336 [4] - flags: 0x81
11:02:05.336 [5] - flags: 0x81
11:02:05.336 [6] - flags: 0x81
11:02:05.336 [7] - flags: 0x81
11:02:05.336 [8] - flags: 0x81
11:02:05.336 [9] - flags: 0x81
11:02:05.336 [PLG] Verified 10 double-bit binary input point event(s)
11:02:05.336 step: 11
11:02:05.336 - Withhold the application layer confirmation for this response
11:02:05.337 steps: 12 to 13
11:02:05.337 - Expect no response within 6000 ms.
11:02:11.341 step: 14
11:02:11.341 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
11:02:11.341 - g4v0, All Objects
11:02:11.341 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
11:02:11.341 g4v0, All Objects
11:02:11.341 --T-> fir: 1 fin: 1 seq: 0
11:02:11.341 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:02:11.341 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:02:11.341 C0 C3 01 04 00 06 09 65
11:02:11.341 step: 15
11:02:11.341 - Read a single fragment response w/ sequence(0x03)
11:02:11.341 - Verify that the response carries the same objects as the previous one
11:02:11.341 <-P-- 05 64 2D 44 01 00 00 04 DB A7
11:02:11.341 C2 E3 81 90 00 04 01 28 0A 00 00 00 81 01 00 81 6E 4B
11:02:11.341 02 00 81 03 00 81 04 00 81 05 00 81 06 00 81 07 7C AC
11:02:11.341 00 81 08 00 81 09 00 81 A0 4C
11:02:11.341 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 45 dest: 1 src: 1024
11:02:11.341 <-T-- fir: 1 fin: 1 seq: 2
11:02:11.342 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
11:02:11.342 g4v1, 2-Byte Count and Index, count: 10
11:02:11.342 [0] - flags: 0x81
11:02:11.342 [1] - flags: 0x81
11:02:11.342 [2] - flags: 0x81
11:02:11.342 [3] - flags: 0x81
11:02:11.342 [4] - flags: 0x81
11:02:11.342 [5] - flags: 0x81
11:02:11.342 [6] - flags: 0x81
11:02:11.342 [7] - flags: 0x81
11:02:11.342 [8] - flags: 0x81
11:02:11.342 [9] - flags: 0x81
11:02:11.342 step: 16
11:02:11.342 - Withhold the application layer confirmation for this response too
11:02:11.342 steps: 17 to 18
11:02:11.342 - Expect no response within 6000 ms.
11:02:17.346 step: 19
11:02:17.346 - Change double-bit binary inputs several times, one or more of them, to create events
11:02:17.346 [PLG] Updated DBBI 0: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.346 [PLG] Updated DBBI 1: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.346 [PLG] Updated DBBI 2: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.346 [PLG] Updated DBBI 3: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.346 [PLG] Updated DBBI 4: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.346 [PLG] Updated DBBI 5: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.346 [PLG] Updated DBBI 6: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.347 [PLG] Updated DBBI 7: value=DETERMINED_OFF, flags=41, timestamp=1793185337346 (UNSYNCHRONIZED_TIME)
11:02:17.347 [PLG] Updated DBBI 8: value=DETERMINED_OFF, flags=41, timestamp=1793185337347 (UNSYNCHRONIZED_TIME)
11:02:17.347 [PLG] Updated DBBI 9: value=DETERMINED_OFF, flags=41, timestamp=1793185337347 (UNSYNCHRONIZED_TIME)
11:02:17.347 The plugin reports the DUT's clock unsynchronized
11:02:17.347 step: 20
11:02:17.347 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
11:02:17.347 - g4v0, All Objects
11:02:17.347 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
11:02:17.347 g4v0, All Objects
11:02:17.347 --T-> fir: 1 fin: 1 seq: 0
11:02:17.347 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:02:17.347 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:02:17.347 C0 C4 01 04 00 06 1B 8C
11:02:17.347 steps: 21 to 23
11:02:17.347 - Read a single fragment response w/ sequence(0x04)
11:02:17.347 - Verify that the response carries every Double-bit Binary event generated and not yet confirmed, in the order they occurred
11:02:17.347 - 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
11:02:17.347 - Verify that an application layer confirmation is requested.
11:02:17.347 - Verify that the events are reported as 3.1r1's rules for event reporting require, for a read of g4v0, by the state of the DUT's clock when it recorded them, where the procedure or the plugin knows it
11:02:17.347 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
11:02:17.347 - Confirm each response that asks for a confirmation
11:02:17.347 <-P-- 05 64 4B 44 01 00 00 04 FD 93
11:02:17.347 C3 E4 81 90 00 04 01 28 14 00 00 00 81 01 00 81 76 A9
11:02:17.347 02 00 81 03 00 81 04 00 81 05 00 81 06 00 81 07 7C AC
11:02:17.347 00 81 08 00 81 09 00 81 00 00 41 01 00 41 02 00 5E 12
11:02:17.347 41 03 00 41 04 00 41 05 00 41 06 00 41 07 00 41 66 3A
11:02:17.347 08 00 41 09 00 41 DD 10
11:02:17.347 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 75 dest: 1 src: 1024
11:02:17.347 <-T-- fir: 1 fin: 1 seq: 3
11:02:17.348 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime)
11:02:17.348 g4v1, 2-Byte Count and Index, count: 20
11:02:17.348 [0] - flags: 0x81
11:02:17.348 [1] - flags: 0x81
11:02:17.348 [2] - flags: 0x81
11:02:17.348 [3] - flags: 0x81
11:02:17.348 [4] - flags: 0x81
11:02:17.348 [5] - flags: 0x81
11:02:17.348 [6] - flags: 0x81
11:02:17.348 [7] - flags: 0x81
11:02:17.348 [8] - flags: 0x81
11:02:17.348 [9] - flags: 0x81
11:02:17.348 [0] - flags: 0x41
11:02:17.348 [1] - flags: 0x41
11:02:17.348 [2] - flags: 0x41
11:02:17.348 [3] - flags: 0x41
11:02:17.348 [4] - flags: 0x41
11:02:17.348 [5] - flags: 0x41
11:02:17.348 [6] - flags: 0x41
11:02:17.348 [7] - flags: 0x41
11:02:17.348 [8] - flags: 0x41
11:02:17.348 [9] - flags: 0x41
11:02:17.348 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
11:02:17.348 --T-> fir: 1 fin: 1 seq: 0
11:02:17.348 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
11:02:17.348 --P-> 05 64 08 C4 00 04 01 00 9A 19
11:02:17.348 C0 C4 00 F9 A1
11:02:17.348 [PLG] Verified 20 double-bit binary input point event(s)
11:02:17.348 step: 24
11:02:17.348 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
11:02:17.348 - g4v0, All Objects
11:02:17.348 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
11:02:17.348 g4v0, All Objects
11:02:17.348 --T-> fir: 1 fin: 1 seq: 0
11:02:17.348 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:02:17.348 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:02:17.348 C0 C5 01 04 00 06 1D AF
11:02:17.349 step: 25
11:02:17.349 - Read a single fragment response w/ sequence(0x05)
11:02:17.349 - Verify that the response is empty
11:02:17.349 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
11:02:17.349 <-P-- 05 64 0A 44 01 00 00 04 67 88
11:02:17.349 C4 C5 81 90 00 40 BE
11:02:17.349 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
11:02:17.349 <-T-- fir: 1 fin: 1 seq: 4
11:02:17.349 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05 IIN(DeviceRestart, NeedTime)
11:02:17.349 Passed procedure: 8.22f