11:55:52.398 Running procedure: 8.5.4.2.2
11:55:52.402 This procedure is enabled because the following options:
11:55:52.402 - class.supportClass3 == true
11:55:52.403 step: 1
11:55:52.403 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
11:55:52.403 - g60v4, All Objects
11:55:52.404 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
11:55:52.404 g60v4, All Objects
11:55:52.404 --T-> fir: 1 fin: 1 seq: 0
11:55:52.404 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:55:52.405 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:55:52.405 C0 C0 01 3C 04 06 7B CC
11:55:52.406 steps: 2 to 3
11:55:52.406 - Read any number of valid responses beginning w/ sequence(0x00) and incrementing by 1 modulo 16
11:55:52.406 - If the response is not Null, verify that the device requests an application layer confirmation.
11:55:52.407 <-P-- 05 64 0A 44 01 00 00 04 67 88
11:55:52.407 C0 C0 81 90 00 9B 2C
11:55:52.407 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
11:55:52.407 <-T-- fir: 1 fin: 1 seq: 0
11:55:52.408 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
11:55:52.408 step: 4
11:55:52.408 - Generate known Class Class 3 event data
11:55:52.408 Updated AI 1024: value=100.0, flags=1, timestamp=DNPTime(1586534152408)
11:55:52.409 Updated AI 0: value=100.0, flags=1, timestamp=DNPTime(1586534152409)
11:55:52.409 Updated AI 65535: value=100.0, flags=1, timestamp=DNPTime(1586534152409)
11:55:52.410 step: 5
11:55:52.410 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
11:55:52.410 - g60v4, 1-Byte Count, count: 1
11:55:52.411 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
11:55:52.411 g60v4, 1-Byte Count, count: 1
11:55:52.411 --T-> fir: 1 fin: 1 seq: 0
11:55:52.411 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 12 dest: 1024 src: 1
11:55:52.412 --P-> 05 64 0C C4 00 04 01 00 F4 54
11:55:52.412 C0 C1 01 3C 04 07 01 FF A8
11:55:52.413 steps: 6 to 10
11:55:52.413 - Read a single fragment response w/ sequence(0x01)
11:55:52.413 - Verify that the device responds with the first Class 3 event data generated
11:55:52.413 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-4
11:55:52.413 - Verify that flag behavior complies with Section 2, Note #5.
11:55:52.413 - Verify that an application layer confirmation is requested.
11:55:52.414 <-P-- 05 64 16 44 01 00 00 04 14 27
11:55:52.414 C1 E1 81 98 00 20 01 28 01 00 00 04 01 64 00 00 D6 BA
11:55:52.414 00 FF FF
11:55:52.415 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 22 dest: 1 src: 1024
11:55:52.415 <-T-- fir: 1 fin: 1 seq: 1
11:55:52.416 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime, Class3Events)
11:55:52.416 g32v1, 2-Byte Count and Index, count: 1
11:55:52.416 [1024] - flags: 0x01 value: 100
11:55:52.416 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
11:55:52.416 --T-> fir: 1 fin: 1 seq: 0
11:55:52.417 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
11:55:52.417 --P-> 05 64 08 C4 00 04 01 00 9A 19
11:55:52.417 C0 C1 00 7D 3D
11:55:52.418 step: 11
11:55:52.418 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
11:55:52.418 - g60v4, 1-Byte Count, count: 2
11:55:52.419 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
11:55:52.419 g60v4, 1-Byte Count, count: 2
11:55:52.419 --T-> fir: 1 fin: 1 seq: 0
11:55:52.419 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 12 dest: 1024 src: 1
11:55:52.420 --P-> 05 64 0C C4 00 04 01 00 F4 54
11:55:52.420 C0 C2 01 3C 04 07 02 4D 61
11:55:52.421 steps: 12 to 13
11:55:52.421 - Read a single fragment response w/ sequence(0x02)
11:55:52.421 - Verify that the device responds with the rest of the Class 3 event data generated
11:55:52.421 - Verify that the response only contains objects, variations, and qualifiers specified in table 8-4
11:55:52.421 - Verify that flag behavior complies with Section 2, Note #5.
11:55:52.421 - Verify that an application layer confirmation is requested.
11:55:52.422 <-P-- 05 64 1D 44 01 00 00 04 98 2E
11:55:52.422 C2 E2 81 90 00 20 01 28 02 00 00 00 01 64 00 00 6E 0B
11:55:52.422 00 FF FF 01 64 00 00 00 80 EA
11:55:52.423 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 29 dest: 1 src: 1024
11:55:52.423 <-T-- fir: 1 fin: 1 seq: 2
11:55:52.424 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
11:55:52.424 g32v1, 2-Byte Count and Index, count: 2
11:55:52.424 [0] - flags: 0x01 value: 100
11:55:52.424 [65535] - flags: 0x01 value: 100
11:55:52.424 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
11:55:52.424 --T-> fir: 1 fin: 1 seq: 0
11:55:52.425 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
11:55:52.425 --P-> 05 64 08 C4 00 04 01 00 9A 19
11:55:52.425 C0 C2 00 D6 8D
11:55:52.426 step: 14
11:55:52.426 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
11:55:52.426 - g60v4, All Objects
11:55:52.427 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
11:55:52.427 g60v4, All Objects
11:55:52.427 --T-> fir: 1 fin: 1 seq: 0
11:55:52.428 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
11:55:52.428 --P-> 05 64 0B C4 00 04 01 00 CA 8A
11:55:52.428 C0 C3 01 3C 04 06 71 A9
11:55:52.429 step: 15
11:55:52.429 - Read a single fragment response w/ sequence(0x03)
11:55:52.429 - Verify that the response is empty
11:55:52.430 <-P-- 05 64 0A 44 01 00 00 04 67 88
11:55:52.430 C3 C3 81 90 00 D0 43
11:55:52.430 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
11:55:52.430 <-T-- fir: 1 fin: 1 seq: 3
11:55:52.431 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
11:55:52.431 Passed procedure: 8.5.4.2.2