12:01:49.907 Running procedure: 8.16.1.2.2
12:01:49.913 This procedure is enabled because the following options:
12:01:49.913 - supports.counter == true
12:01:49.914 step: 1
12:01:49.914 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
12:01:49.914 - g20v0, All Objects
12:01:49.916 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
12:01:49.916 g20v0, All Objects
12:01:49.916 --T-> fir: 1 fin: 1 seq: 0
12:01:49.916 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:49.917 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:49.917 C0 C1 01 14 00 06 FC F5
12:01:49.918 steps: 2 to 3
12:01:49.918 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
12:01:49.918 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-5
12:01:49.920 <-P-- 05 64 32 44 01 00 00 04 F8 9B
12:01:49.920 C0 C1 81 90 00 14 02 01 00 00 00 00 01 01 00 14 7D D6
12:01:49.920 02 01 29 00 29 00 01 01 00 14 02 01 00 04 00 04 A5 78
12:01:49.920 01 01 00 14 02 01 FF FF FF FF 01 01 00 0E 40
12:01:49.920 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 50 dest: 1 src: 1024
12:01:49.921 <-T-- fir: 1 fin: 1 seq: 0
12:01:49.924 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
12:01:49.924 g20v2, 2-Byte Start/Stop, start: 0 stop: 0
12:01:49.924 [0] - flags: 0x01 count: 1
12:01:49.924 g20v2, 2-Byte Start/Stop, start: 41 stop: 41
12:01:49.924 [41] - flags: 0x01 count: 1
12:01:49.924 g20v2, 2-Byte Start/Stop, start: 1024 stop: 1024
12:01:49.924 [1024] - flags: 0x01 count: 1
12:01:49.924 g20v2, 2-Byte Start/Stop, start: 65535 stop: 65535
12:01:49.924 [65535] - flags: 0x01 count: 1
12:01:49.925 step: 4
12:01:49.925 - Generate binary counter input data
12:01:49.926 Updated Counter 65535: value=2, flags=1, timestamp=DNPTime(1586534509925)
12:01:49.926 Updated Counter 1024: value=2, flags=1, timestamp=DNPTime(1586534509926)
12:01:49.927 Updated Counter 41: value=2, flags=1, timestamp=DNPTime(1586534509926)
12:01:49.927 step: 5
12:01:49.927 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:01:49.927 - g20v0, All Objects
12:01:49.927 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:01:49.927 g20v0, All Objects
12:01:49.927 --T-> fir: 1 fin: 1 seq: 0
12:01:49.928 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:01:49.928 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:01:49.928 C0 C2 01 14 00 06 F6 90
12:01:49.930 steps: 6 to 8
12:01:49.930 - Read any number of valid responses beginning w/ sequence(0x02) and incrementing by 1 modulo 16
12:01:49.930 - Verify that the reported values match the values recorded previously plus the counts generated
12:01:49.930 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-5
12:01:49.930 - Verify that flag behavior complies with Section 2, Note #5.
12:01:49.931 <-P-- 05 64 32 44 01 00 00 04 F8 9B
12:01:49.931 C1 C2 81 94 00 14 02 01 00 00 00 00 01 01 00 14 4C 18
12:01:49.931 02 01 29 00 29 00 01 02 00 14 02 01 00 04 00 04 9F 56
12:01:49.931 01 02 00 14 02 01 FF FF FF FF 01 02 00 F5 88
12:01:49.932 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 50 dest: 1 src: 1024
12:01:49.932 <-T-- fir: 1 fin: 1 seq: 1
12:01:49.935 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime, Class2Events)
12:01:49.935 g20v2, 2-Byte Start/Stop, start: 0 stop: 0
12:01:49.935 [0] - flags: 0x01 count: 1
12:01:49.935 g20v2, 2-Byte Start/Stop, start: 41 stop: 41
12:01:49.935 [41] - flags: 0x01 count: 2
12:01:49.935 g20v2, 2-Byte Start/Stop, start: 1024 stop: 1024
12:01:49.935 [1024] - flags: 0x01 count: 2
12:01:49.935 g20v2, 2-Byte Start/Stop, start: 65535 stop: 65535
12:01:49.935 [65535] - flags: 0x01 count: 2
12:01:49.936 Passed procedure: 8.16.1.2.2