12:01:51.573 Running procedure: 8.16.2.2.2
12:01:51.578 This procedure is enabled because the following options:
12:01:51.578 - supports.frozenCounter == true
12:01:51.579 step: 1
12:01:51.579 - Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
12:01:51.579 - g20v0, All Objects
12:01:51.580 --A-> Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
12:01:51.580 g20v0, All Objects
12:01:51.580 --T-> fir: 1 fin: 1 seq: 0
12:01:51.581 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:51.581 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:51.581 C0 C1 07 14 00 06 7E E1
12:01:51.582 step: 2
12:01:51.582 - Read a single fragment response w/ sequence(0x01)
12:01:51.582 - Verify that the response is empty
12:01:51.583 <-P-- 05 64 0A 44 01 00 00 04 67 88
12:01:51.583 C0 C1 81 90 00 73 EE
12:01:51.583 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
12:01:51.583 <-T-- fir: 1 fin: 1 seq: 0
12:01:51.584 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
12:01:51.585 step: 3
12:01:51.585 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:01:51.585 - g21v0, All Objects
12:01:51.585 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:01:51.585 g21v0, All Objects
12:01:51.585 --T-> fir: 1 fin: 1 seq: 0
12:01:51.586 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:51.586 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:51.586 C0 C2 01 15 00 06 4E 89
12:01:51.587 step: 4
12:01:51.587 - Read any number of valid responses beginning w/ sequence(0x02) and incrementing by 1 modulo 16
12:01:51.587 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-6
12:01:51.588 <-P-- 05 64 32 44 01 00 00 04 F8 9B
12:01:51.588 C1 C2 81 90 00 15 02 01 00 00 00 00 01 01 00 15 09 09
12:01:51.588 02 01 29 00 29 00 01 01 00 15 02 01 00 04 00 04 C7 27
12:01:51.588 01 01 00 15 02 01 FF FF FF FF 01 01 00 6C 83
12:01:51.589 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 50 dest: 1 src: 1024
12:01:51.589 <-T-- fir: 1 fin: 1 seq: 1
12:01:51.591 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
12:01:51.591 g21v2, 2-Byte Start/Stop, start: 0 stop: 0
12:01:51.591 [0] - flags: 0x01 count: 1
12:01:51.591 g21v2, 2-Byte Start/Stop, start: 41 stop: 41
12:01:51.591 [41] - flags: 0x01 count: 1
12:01:51.591 g21v2, 2-Byte Start/Stop, start: 1024 stop: 1024
12:01:51.591 [1024] - flags: 0x01 count: 1
12:01:51.591 g21v2, 2-Byte Start/Stop, start: 65535 stop: 65535
12:01:51.591 [65535] - flags: 0x01 count: 1
12:01:51.592 step: 5
12:01:51.592 - Record the values for future reference
12:01:51.593 step: 6
12:01:51.593 - Generate binary counter input data
12:01:51.594 Updated Counter 1024: value=2, flags=1, timestamp=DNPTime(1586534511593)
12:01:51.594 Updated Counter 65535: value=2, flags=1, timestamp=DNPTime(1586534511594)
12:01:51.595 Updated Counter 1024: value=3, flags=1, timestamp=DNPTime(1586534511594)
12:01:51.595 step: 7
12:01:51.595 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
12:01:51.595 - g21v0, All Objects
12:01:51.596 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
12:01:51.596 g21v0, All Objects
12:01:51.596 --T-> fir: 1 fin: 1 seq: 0
12:01:51.596 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:51.597 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:51.597 C0 C3 01 15 00 06 48 AA
12:01:51.599 steps: 8 to 11
12:01:51.599 - Read any number of valid responses beginning w/ sequence(0x03) and incrementing by 1 modulo 16
12:01:51.599 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-6
12:01:51.599 - Verify that flag behavior complies with Section 2, Note #5.
12:01:51.599 - Verify that the reported values match the values recorded previously
12:01:51.600 <-P-- 05 64 32 44 01 00 00 04 F8 9B
12:01:51.600 C2 C3 81 94 00 15 02 01 00 00 00 00 01 01 00 15 10 80
12:01:51.600 02 01 29 00 29 00 01 01 00 15 02 01 00 04 00 04 C7 27
12:01:51.600 01 01 00 15 02 01 FF FF FF FF 01 01 00 6C 83
12:01:51.600 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 50 dest: 1 src: 1024
12:01:51.600 <-T-- fir: 1 fin: 1 seq: 2
12:01:51.603 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime, Class2Events)
12:01:51.603 g21v2, 2-Byte Start/Stop, start: 0 stop: 0
12:01:51.603 [0] - flags: 0x01 count: 1
12:01:51.603 g21v2, 2-Byte Start/Stop, start: 41 stop: 41
12:01:51.603 [41] - flags: 0x01 count: 1
12:01:51.603 g21v2, 2-Byte Start/Stop, start: 1024 stop: 1024
12:01:51.603 [1024] - flags: 0x01 count: 1
12:01:51.603 g21v2, 2-Byte Start/Stop, start: 65535 stop: 65535
12:01:51.603 [65535] - flags: 0x01 count: 1
12:01:51.605 step: 12
12:01:51.605 - Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
12:01:51.605 - g20v0, All Objects
12:01:51.605 --A-> Freeze(0x07) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
12:01:51.605 g20v0, All Objects
12:01:51.606 --T-> fir: 1 fin: 1 seq: 0
12:01:51.606 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:51.606 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:51.606 C0 C4 07 14 00 06 60 4E
12:01:51.607 step: 13
12:01:51.607 - Read a single fragment response w/ sequence(0x04)
12:01:51.607 - Verify that the response is empty
12:01:51.608 <-P-- 05 64 0A 44 01 00 00 04 67 88
12:01:51.608 C3 C4 81 96 00 95 B9
12:01:51.608 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
12:01:51.609 <-T-- fir: 1 fin: 1 seq: 3
12:01:51.609 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime, Class2Events, Class1Events)
12:01:51.610 step: 14
12:01:51.610 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
12:01:51.610 - g21v0, All Objects
12:01:51.610 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05
12:01:51.610 g21v0, All Objects
12:01:51.611 --T-> fir: 1 fin: 1 seq: 0
12:01:51.611 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:51.611 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:51.611 C0 C5 01 15 00 06 5C 60
12:01:51.613 steps: 15 to 16
12:01:51.613 - Read any number of valid responses beginning w/ sequence(0x05) and incrementing by 1 modulo 16
12:01:51.613 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-6
12:01:51.613 - Verify that the reported values match the values recorded previously plus the counts generated
12:01:51.614 <-P-- 05 64 32 44 01 00 00 04 F8 9B
12:01:51.614 C4 C5 81 96 00 15 02 01 00 00 00 00 01 01 00 15 1E F7
12:01:51.614 02 01 29 00 29 00 01 01 00 15 02 01 00 04 00 04 C7 27
12:01:51.614 01 03 00 15 02 01 FF FF FF FF 01 02 00 70 A7
12:01:51.614 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 50 dest: 1 src: 1024
12:01:51.615 <-T-- fir: 1 fin: 1 seq: 4
12:01:51.617 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x05 IIN(DeviceRestart, NeedTime, Class2Events, Class1Events)
12:01:51.617 g21v2, 2-Byte Start/Stop, start: 0 stop: 0
12:01:51.617 [0] - flags: 0x01 count: 1
12:01:51.617 g21v2, 2-Byte Start/Stop, start: 41 stop: 41
12:01:51.617 [41] - flags: 0x01 count: 1
12:01:51.617 g21v2, 2-Byte Start/Stop, start: 1024 stop: 1024
12:01:51.617 [1024] - flags: 0x01 count: 3
12:01:51.617 g21v2, 2-Byte Start/Stop, start: 65535 stop: 65535
12:01:51.617 [65535] - flags: 0x01 count: 2
12:01:51.617 Passed procedure: 8.16.2.2.2