8.16.2.2.3 Binary Counter, Freeze (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

05:29:51.584 Running procedure: 8.16.2.2.3
05:29:51.586 This procedure is enabled because the following options:
05:29:51.586 - supports.frozenCounter == true
05:29:51.586 - supports.frozenCounterReads == true
05:29:51.587 step: 1
05:29:51.587 - Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:29:51.587 - g20v0, All Objects
05:29:51.587 --A-> Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:29:51.587 g20v0, All Objects
05:29:51.587 --T-> fir: 1 fin: 1 seq: 0
05:29:51.587 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:51.587 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:51.587 C0 C1 07 14 00 06 7E E1
05:29:51.587 step: 2
05:29:51.587 - Read a single fragment response w/ sequence(0x01)
05:29:51.587 - Verify that the response is empty
05:29:51.587 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:29:51.588 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:29:51.588 C0 C1 81 92 00 96 F5
05:29:51.588 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:29:51.588 <-T-- fir: 1 fin: 1 seq: 0
05:29:51.588 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime, Class1Events)
05:29:51.588 step: 3
05:29:51.588 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:29:51.588 - g23v0, All Objects
05:29:51.588 - g21v0, All Objects
05:29:51.588 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:29:51.588 g23v0, All Objects
05:29:51.588 g21v0, All Objects
05:29:51.588 --T-> fir: 1 fin: 1 seq: 0
05:29:51.588 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 14 dest: 1024 src: 1
05:29:51.588 --P-> 05 64 0E C4 00 04 01 00 43 72
05:29:51.588 C0 C2 01 17 00 06 15 00 06 45 14
05:29:51.589 steps: 3.1 to 3.3
05:29:51.589 - Read any number of valid responses beginning w/ sequence(0x02) and incrementing by 1 modulo 16
05:29:51.589 - Verify that the response holds frozen counter events (g23v1 or g23v2, qualifier 0x17 or 0x28), followed by frozen counters (g21v1, g21v2, g21v9 or g21v10, qualifier 0x00 or 0x01), and nothing else
05:29:51.589 - Verify that each fragment followed by another, or carrying events, asks for an application layer confirmation.
05:29:51.589 - Verify that every point is reported in both objects, and that each point's latest event (g23) has the value of its frozen counter (g21)
05:29:51.589 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-6
05:29:51.589 - Verify that the response contains objects
05:29:51.589 - Confirm each response that asks for a confirmation
05:29:51.589 <-P-- 05 64 7A 44 01 00 00 04 59 AF
05:29:51.589 C1 E2 81 90 00 17 01 28 0A 00 00 00 01 00 00 00 6F 68
05:29:51.589 00 01 00 01 00 00 00 00 02 00 01 00 00 00 00 03 FD 0D
05:29:51.589 00 01 00 00 00 00 04 00 01 00 00 00 00 05 00 01 F0 14
05:29:51.589 00 00 00 00 06 00 01 00 00 00 00 07 00 01 00 00 97 3C
05:29:51.589 00 00 08 00 01 00 00 00 00 09 00 01 00 00 00 00 67 B4
05:29:51.589 15 02 01 00 00 09 00 01 00 00 01 00 00 01 00 00 C7 5B
05:29:51.589 01 00 00 01 00 00 01 00 00 01 00 00 01 00 00 01 FE 85
05:29:51.589 00 00 01 00 00 47 E6
05:29:51.589 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 122 dest: 1 src: 1024
05:29:51.589 <-T-- fir: 1 fin: 1 seq: 1
05:29:51.589 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
05:29:51.589 g23v1, 2-Byte Count and Index, count: 10
05:29:51.589 [0] - flags: 0x01 count: 0
05:29:51.589 [1] - flags: 0x01 count: 0
05:29:51.589 [2] - flags: 0x01 count: 0
05:29:51.589 [3] - flags: 0x01 count: 0
05:29:51.589 [4] - flags: 0x01 count: 0
05:29:51.589 [5] - flags: 0x01 count: 0
05:29:51.589 [6] - flags: 0x01 count: 0
05:29:51.589 [7] - flags: 0x01 count: 0
05:29:51.589 [8] - flags: 0x01 count: 0
05:29:51.589 [9] - flags: 0x01 count: 0
05:29:51.589 g21v2, 2-Byte Start/Stop, start: 0 stop: 9
05:29:51.589 [0] - flags: 0x01 count: 0
05:29:51.589 [1] - flags: 0x01 count: 0
05:29:51.589 [2] - flags: 0x01 count: 0
05:29:51.589 [3] - flags: 0x01 count: 0
05:29:51.589 [4] - flags: 0x01 count: 0
05:29:51.589 [5] - flags: 0x01 count: 0
05:29:51.589 [6] - flags: 0x01 count: 0
05:29:51.589 [7] - flags: 0x01 count: 0
05:29:51.589 [8] - flags: 0x01 count: 0
05:29:51.589 [9] - flags: 0x01 count: 0
05:29:51.589 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:29:51.589 --T-> fir: 1 fin: 1 seq: 0
05:29:51.589 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:51.589 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:51.589 C0 C2 00 D6 8D
05:29:51.594 step: 5
05:29:51.594 - Note the counters' current values, for a later check
05:29:51.594 [PLG] Recorded values:
05:29:51.594 [PLG] Updated Counter 0: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 1: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 2: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 3: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 4: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 5: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 6: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 7: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 8: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 [PLG] Updated Counter 9: value=0, flags=1, timestamp=0 (INVALID_TIME)
05:29:51.594 step: 6
05:29:51.594 - Make every binary counter count up
05:29:51.594 [PLG] Updated Counter 0: value=1, flags=1, timestamp=1793251791594 (UNSYNCHRONIZED_TIME)
05:29:51.594 [PLG] Updated Counter 1: value=1, flags=1, timestamp=1793251791594 (UNSYNCHRONIZED_TIME)
05:29:51.594 [PLG] Updated Counter 2: value=1, flags=1, timestamp=1793251791594 (UNSYNCHRONIZED_TIME)
05:29:51.594 [PLG] Updated Counter 3: value=1, flags=1, timestamp=1793251791594 (UNSYNCHRONIZED_TIME)
05:29:51.595 [PLG] Updated Counter 4: value=1, flags=1, timestamp=1793251791594 (UNSYNCHRONIZED_TIME)
05:29:51.595 [PLG] Updated Counter 5: value=1, flags=1, timestamp=1793251791595 (UNSYNCHRONIZED_TIME)
05:29:51.595 [PLG] Updated Counter 6: value=1, flags=1, timestamp=1793251791595 (UNSYNCHRONIZED_TIME)
05:29:51.595 [PLG] Updated Counter 7: value=1, flags=1, timestamp=1793251791595 (UNSYNCHRONIZED_TIME)
05:29:51.595 [PLG] Updated Counter 8: value=1, flags=1, timestamp=1793251791595 (UNSYNCHRONIZED_TIME)
05:29:51.595 [PLG] Updated Counter 9: value=1, flags=1, timestamp=1793251791595 (UNSYNCHRONIZED_TIME)
05:29:51.595 step: 7
05:29:51.595 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:29:51.595 - g21v0, All Objects
05:29:51.595 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:29:51.595 g21v0, All Objects
05:29:51.595 --T-> fir: 1 fin: 1 seq: 0
05:29:51.595 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:51.595 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:51.595 C0 C3 01 15 00 06 48 AA
05:29:51.595 steps: 8 to 11
05:29:51.595 - Read any number of valid responses beginning w/ sequence(0x03) and incrementing by 1 modulo 16
05:29:51.595 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-6
05:29:51.595 - Verify that the response contains objects
05:29:51.595 - 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:51.595 - Verify that each counter still equals its recorded value
05:29:51.595 - Confirm each response that asks for a confirmation
05:29:51.596 <-P-- 05 64 2F 44 01 00 00 04 6C 81
05:29:51.596 C2 C3 81 94 00 15 02 01 00 00 09 00 01 00 00 01 80 DD
05:29:51.596 00 00 01 00 00 01 00 00 01 00 00 01 00 00 01 00 DB 49
05:29:51.596 00 01 00 00 01 00 00 01 00 00 61 8D
05:29:51.596 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 47 dest: 1 src: 1024
05:29:51.596 <-T-- fir: 1 fin: 1 seq: 2
05:29:51.596 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime, Class2Events)
05:29:51.596 g21v2, 2-Byte Start/Stop, start: 0 stop: 9
05:29:51.596 [0] - flags: 0x01 count: 0
05:29:51.596 [1] - flags: 0x01 count: 0
05:29:51.596 [2] - flags: 0x01 count: 0
05:29:51.596 [3] - flags: 0x01 count: 0
05:29:51.596 [4] - flags: 0x01 count: 0
05:29:51.596 [5] - flags: 0x01 count: 0
05:29:51.596 [6] - flags: 0x01 count: 0
05:29:51.596 [7] - flags: 0x01 count: 0
05:29:51.596 [8] - flags: 0x01 count: 0
05:29:51.596 [9] - flags: 0x01 count: 0
05:29:51.597 [PLG] Verified 10 counter point(s)
05:29:51.597 step: 12
05:29:51.597 - Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:29:51.597 - g20v0, All Objects
05:29:51.597 --A-> Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:29:51.597 g20v0, All Objects
05:29:51.597 --T-> fir: 1 fin: 1 seq: 0
05:29:51.597 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:29:51.597 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:29:51.597 C0 C4 07 14 00 06 60 4E
05:29:51.597 step: 13
05:29:51.597 - Read a single fragment response w/ sequence(0x04)
05:29:51.597 - Verify that the response is empty
05:29:51.597 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:29:51.597 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:29:51.597 C3 C4 81 96 00 95 B9
05:29:51.597 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:29:51.597 <-T-- fir: 1 fin: 1 seq: 3
05:29:51.597 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime, Class2Events, Class1Events)
05:29:51.597 step: 14.1
05:29:51.597 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
05:29:51.597 - g23v0, All Objects
05:29:51.597 - g21v0, All Objects
05:29:51.597 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
05:29:51.597 g23v0, All Objects
05:29:51.597 g21v0, All Objects
05:29:51.597 --T-> fir: 1 fin: 1 seq: 0
05:29:51.597 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 14 dest: 1024 src: 1
05:29:51.597 --P-> 05 64 0E C4 00 04 01 00 43 72
05:29:51.597 C0 C5 01 17 00 06 15 00 06 3B 76
05:29:51.598 steps: 14.2 to 16
05:29:51.598 - Read any number of valid responses beginning w/ sequence(0x05) and incrementing by 1 modulo 16
05:29:51.598 - Verify that the response holds frozen counter events (g23v1 or g23v2, qualifier 0x17 or 0x28), followed by frozen counters (g21v1, g21v2, g21v9 or g21v10, qualifier 0x00 or 0x01), and nothing else
05:29:51.598 - Verify that each fragment followed by another, or carrying events, asks for an application layer confirmation.
05:29:51.598 - Verify that every point is reported in both objects, and that each point's latest event (g23) has the value of its frozen counter (g21)
05:29:51.598 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-6
05:29:51.598 - Verify that the response contains objects
05:29:51.598 - Verify that each counter equals its recorded value plus the counts generated since that value was recorded
05:29:51.598 - Confirm each response that asks for a confirmation
05:29:51.598 <-P-- 05 64 7A 44 01 00 00 04 59 AF
05:29:51.598 C4 E5 81 94 00 17 01 28 0A 00 00 00 01 01 00 00 B6 31
05:29:51.598 00 01 00 01 01 00 00 00 02 00 01 01 00 00 00 03 1C C2
05:29:51.598 00 01 01 00 00 00 04 00 01 01 00 00 00 05 00 01 62 75
05:29:51.598 01 00 00 00 06 00 01 01 00 00 00 07 00 01 01 00 94 04
05:29:51.598 00 00 08 00 01 01 00 00 00 09 00 01 01 00 00 00 01 60
05:29:51.598 15 02 01 00 00 09 00 01 01 00 01 01 00 01 01 00 9D C5
05:29:51.598 01 01 00 01 01 00 01 01 00 01 01 00 01 01 00 01 9F 75
05:29:51.598 01 00 01 01 00 0F 6E
05:29:51.598 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 122 dest: 1 src: 1024
05:29:51.598 <-T-- fir: 1 fin: 1 seq: 4
05:29:51.598 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x05 IIN(DeviceRestart, NeedTime, Class2Events)
05:29:51.598 g23v1, 2-Byte Count and Index, count: 10
05:29:51.598 [0] - flags: 0x01 count: 1
05:29:51.598 [1] - flags: 0x01 count: 1
05:29:51.598 [2] - flags: 0x01 count: 1
05:29:51.598 [3] - flags: 0x01 count: 1
05:29:51.598 [4] - flags: 0x01 count: 1
05:29:51.598 [5] - flags: 0x01 count: 1
05:29:51.598 [6] - flags: 0x01 count: 1
05:29:51.598 [7] - flags: 0x01 count: 1
05:29:51.598 [8] - flags: 0x01 count: 1
05:29:51.598 [9] - flags: 0x01 count: 1
05:29:51.598 g21v2, 2-Byte Start/Stop, start: 0 stop: 9
05:29:51.598 [0] - flags: 0x01 count: 1
05:29:51.598 [1] - flags: 0x01 count: 1
05:29:51.598 [2] - flags: 0x01 count: 1
05:29:51.598 [3] - flags: 0x01 count: 1
05:29:51.598 [4] - flags: 0x01 count: 1
05:29:51.598 [5] - flags: 0x01 count: 1
05:29:51.598 [6] - flags: 0x01 count: 1
05:29:51.598 [7] - flags: 0x01 count: 1
05:29:51.598 [8] - flags: 0x01 count: 1
05:29:51.598 [9] - flags: 0x01 count: 1
05:29:51.598 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
05:29:51.598 --T-> fir: 1 fin: 1 seq: 0
05:29:51.598 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:29:51.598 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:29:51.598 C0 C5 00 B7 0A
05:29:51.599 [PLG] Verified 10 counter point(s)
05:29:51.599 Passed procedure: 8.16.2.2.3