8.17.2f Binary Counters, Event Without Confirm (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

05:30:03.246 Running procedure: 8.17.2f
05:30:03.247 This procedure is enabled because the following options:
05:30:03.247 - supports.counterEventReads == true
05:30:03.247 - supports.counter == true
05:30:03.247 - supports.counterChangeEvents == true
05:30:03.247 step: 1
05:30:03.247 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:30:03.247 - g22v0, All Objects
05:30:03.247 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:30:03.247 g22v0, All Objects
05:30:03.248 --T-> fir: 1 fin: 1 seq: 0
05:30:03.248 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:30:03.251 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:30:03.251 C0 C1 01 16 00 06 8C C6
05:30:03.251 steps: 2 to 3
05:30:03.251 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
05:30:03.251 - If the response carries data, verify that it asks for an application layer confirmation.
05:30:03.251 - Confirm each response that asks for a confirmation
05:30:03.251 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:30:03.251 C0 C1 81 90 00 73 EE
05:30:03.251 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:30:03.251 <-T-- fir: 1 fin: 1 seq: 0
05:30:03.251 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
05:30:03.252 step: 4
05:30:03.252 - Make every binary counter count up
05:30:03.252 [PLG] Updated Counter 0: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 1: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 2: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 3: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 4: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 5: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 6: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.252 [PLG] Updated Counter 7: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.253 [PLG] Updated Counter 8: value=1, flags=1, timestamp=1793251803252 (UNSYNCHRONIZED_TIME)
05:30:03.253 [PLG] Updated Counter 9: value=1, flags=1, timestamp=1793251803253 (UNSYNCHRONIZED_TIME)
05:30:03.253 step: 5
05:30:03.253 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:30:03.253 - g22v0, All Objects
05:30:03.253 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:30:03.253 g22v0, All Objects
05:30:03.253 --T-> fir: 1 fin: 1 seq: 0
05:30:03.253 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:30:03.253 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:30:03.253 C0 C2 01 16 00 06 86 A3
05:30:03.253 steps: 6 to 7
05:30:03.253 - Read a single fragment response w/ sequence(0x02)
05:30:03.253 - Verify that the response holds every counter event generated
05:30:03.253 - Verify that an application layer confirmation is requested.
05:30:03.253 <-P-- 05 64 55 44 01 00 00 04 39 1A
05:30:03.253 C1 E2 81 90 00 16 01 28 0A 00 00 00 01 01 00 00 59 67
05:30:03.253 00 01 00 01 01 00 00 00 02 00 01 01 00 00 00 03 1C C2
05:30:03.253 00 01 01 00 00 00 04 00 01 01 00 00 00 05 00 01 62 75
05:30:03.253 01 00 00 00 06 00 01 01 00 00 00 07 00 01 01 00 94 04
05:30:03.253 00 00 08 00 01 01 00 00 00 09 00 01 01 00 00 00 01 60
05:30:03.253 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 85 dest: 1 src: 1024
05:30:03.253 <-T-- fir: 1 fin: 1 seq: 1
05:30:03.254 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
05:30:03.254 g22v1, 2-Byte Count and Index, count: 10
05:30:03.254 [0] - flags: 0x01 count: 1
05:30:03.254 [1] - flags: 0x01 count: 1
05:30:03.254 [2] - flags: 0x01 count: 1
05:30:03.254 [3] - flags: 0x01 count: 1
05:30:03.254 [4] - flags: 0x01 count: 1
05:30:03.254 [5] - flags: 0x01 count: 1
05:30:03.254 [6] - flags: 0x01 count: 1
05:30:03.254 [7] - flags: 0x01 count: 1
05:30:03.254 [8] - flags: 0x01 count: 1
05:30:03.254 [9] - flags: 0x01 count: 1
05:30:03.254 [PLG] Verified 10 counter point event(s)
05:30:03.254 step: 8
05:30:03.254 - Withhold the application-layer confirmation for this response.
05:30:03.254 steps: 9 to 10
05:30:03.254 - Expect no response within 6000 ms.
05:30:09.260 step: 11
05:30:09.260 - Make every binary counter count up
05:30:09.260 [PLG] Updated Counter 0: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 1: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 2: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 3: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 4: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 5: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 6: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.260 [PLG] Updated Counter 7: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.261 [PLG] Updated Counter 8: value=2, flags=1, timestamp=1793251809260 (UNSYNCHRONIZED_TIME)
05:30:09.261 [PLG] Updated Counter 9: value=2, flags=1, timestamp=1793251809261 (UNSYNCHRONIZED_TIME)
05:30:09.261 step: 12
05:30:09.261 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:30:09.261 - g22v0, All Objects
05:30:09.261 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:30:09.261 g22v0, All Objects
05:30:09.261 --T-> fir: 1 fin: 1 seq: 0
05:30:09.261 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:30:09.261 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:30:09.261 C0 C3 01 16 00 06 80 80
05:30:09.261 steps: 13 to 18
05:30:09.261 - Read a single fragment response w/ sequence(0x03)
05:30:09.261 - Verify the device responds with values representing the current state of the counters
05:30:09.261 - The DUT may also report the previous state before the present one
05:30:09.261 - Verify that an application layer confirmation is requested.
05:30:09.261 - Verify that the device responds with events, of only Set(g22v1, g22v2)
05:30:09.261 - Verify that the objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
05:30:09.261 - 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:09.261 - Confirm each response that asks for a confirmation
05:30:09.262 <-P-- 05 64 9B 44 01 00 00 04 C2 54
05:30:09.262 C2 E3 81 90 00 16 01 28 14 00 00 00 01 01 00 00 70 37
05:30:09.262 00 01 00 01 01 00 00 00 02 00 01 01 00 00 00 03 1C C2
05:30:09.262 00 01 01 00 00 00 04 00 01 01 00 00 00 05 00 01 62 75
05:30:09.262 01 00 00 00 06 00 01 01 00 00 00 07 00 01 01 00 94 04
05:30:09.262 00 00 08 00 01 01 00 00 00 09 00 01 01 00 00 00 01 60
05:30:09.262 00 00 01 02 00 00 00 01 00 01 02 00 00 00 02 00 88 C3
05:30:09.262 01 02 00 00 00 03 00 01 02 00 00 00 04 00 01 02 ED BC
05:30:09.262 00 00 00 05 00 01 02 00 00 00 06 00 01 02 00 00 23 D6
05:30:09.262 00 07 00 01 02 00 00 00 08 00 01 02 00 00 00 09 EE F9
05:30:09.262 00 01 02 00 00 00 50 14
05:30:09.262 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 155 dest: 1 src: 1024
05:30:09.262 <-T-- fir: 1 fin: 1 seq: 2
05:30:09.262 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
05:30:09.262 g22v1, 2-Byte Count and Index, count: 20
05:30:09.262 [0] - flags: 0x01 count: 1
05:30:09.262 [1] - flags: 0x01 count: 1
05:30:09.262 [2] - flags: 0x01 count: 1
05:30:09.262 [3] - flags: 0x01 count: 1
05:30:09.262 [4] - flags: 0x01 count: 1
05:30:09.262 [5] - flags: 0x01 count: 1
05:30:09.262 [6] - flags: 0x01 count: 1
05:30:09.262 [7] - flags: 0x01 count: 1
05:30:09.262 [8] - flags: 0x01 count: 1
05:30:09.262 [9] - flags: 0x01 count: 1
05:30:09.262 [0] - flags: 0x01 count: 2
05:30:09.262 [1] - flags: 0x01 count: 2
05:30:09.262 [2] - flags: 0x01 count: 2
05:30:09.262 [3] - flags: 0x01 count: 2
05:30:09.262 [4] - flags: 0x01 count: 2
05:30:09.262 [5] - flags: 0x01 count: 2
05:30:09.262 [6] - flags: 0x01 count: 2
05:30:09.262 [7] - flags: 0x01 count: 2
05:30:09.262 [8] - flags: 0x01 count: 2
05:30:09.262 [9] - flags: 0x01 count: 2
05:30:09.262 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:30:09.262 --T-> fir: 1 fin: 1 seq: 0
05:30:09.262 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:30:09.262 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:30:09.262 C0 C3 00 98 26
05:30:09.263 [PLG] Verified the current value of 10 counter(s)
05:30:09.263 step: 19
05:30:09.263 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:30:09.263 - g22v0, All Objects
05:30:09.263 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
05:30:09.263 g22v0, All Objects
05:30:09.263 --T-> fir: 1 fin: 1 seq: 0
05:30:09.263 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:30:09.263 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:30:09.263 C0 C4 01 16 00 06 92 69
05:30:09.263 step: 20
05:30:09.263 - Read a single fragment response w/ sequence(0x04)
05:30:09.263 - Verify that the response is empty
05:30:09.263 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:30:09.263 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:30:09.263 C3 C4 81 90 00 BA 95
05:30:09.263 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:30:09.263 <-T-- fir: 1 fin: 1 seq: 3
05:30:09.263 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime)
05:30:09.263 Passed procedure: 8.17.2f