8.5.5.2.2 Multiple Object Request, Class 1, 2, 3, and 0 (revision 2.7, subset level 2)

Device under test: Step Function I/O dnp3 outstation

10:57:18.385 Running procedure: 8.5.5.2.2
10:57:18.386 step: 1
10:57:18.386 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
10:57:18.386 - g60v2, All Objects
10:57:18.386 - g60v3, All Objects
10:57:18.386 - g60v4, All Objects
10:57:18.387 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
10:57:18.387 g60v2, All Objects
10:57:18.387 g60v3, All Objects
10:57:18.387 g60v4, All Objects
10:57:18.387 --T-> fir: 1 fin: 1 seq: 0
10:57:18.387 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 17 dest: 1024 src: 1
10:57:18.387 --P-> 05 64 11 C4 00 04 01 00 60 4E
10:57:18.387 C0 C0 01 3C 02 06 3C 03 06 3C 04 06 9E 30
10:57:18.387 steps: 2 to 3
10:57:18.387 - Read any number of valid responses beginning w/ sequence(0x00) and incrementing by 1 modulo 16
10:57:18.387 - If the response carries data, verify that it asks for an application layer confirmation.
10:57:18.387 - Confirm each response that asks for a confirmation
10:57:18.388 <-P-- 05 64 0A 44 01 00 00 04 67 88
10:57:18.388 C0 C0 81 90 00 9B 2C
10:57:18.388 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
10:57:18.388 <-T-- fir: 1 fin: 1 seq: 0
10:57:18.388 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
10:57:18.388 step: 4
10:57:18.388 - Generate known Class 1, 2 and 3 event data
10:57:18.388 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 1: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 2: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 3: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 4: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 5: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 6: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 7: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 8: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated BI 9: value=true, flags=81, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 0: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 1: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 2: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 3: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 4: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 5: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 6: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 7: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 8: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated Counter 9: value=1, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.388 [PLG] Updated AI 0: value=100.0, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 1: value=100.0, flags=1, timestamp=1793185038388 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 2: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 3: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 4: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 5: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 6: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 7: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 8: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 [PLG] Updated AI 9: value=100.0, flags=1, timestamp=1793185038389 (UNSYNCHRONIZED_TIME)
10:57:18.389 step: 5
10:57:18.389 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:57:18.389 - g60v2, All Objects
10:57:18.389 - g60v3, All Objects
10:57:18.389 - g60v4, All Objects
10:57:18.389 - g60v1, All Objects
10:57:18.389 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:57:18.389 g60v2, All Objects
10:57:18.389 g60v3, All Objects
10:57:18.389 g60v4, All Objects
10:57:18.389 g60v1, All Objects
10:57:18.389 --T-> fir: 1 fin: 1 seq: 0
10:57:18.389 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 20 dest: 1024 src: 1
10:57:18.389 --P-> 05 64 14 C4 00 04 01 00 E9 B6
10:57:18.389 C0 C1 01 3C 02 06 3C 03 06 3C 04 06 3C 01 06 7A 6F
10:57:18.389 steps: 6 to 13
10:57:18.389 - Read any number of valid responses beginning w/ sequence(0x01) and incrementing by 1 modulo 16
10:57:18.389 - Verify that one response carries every Class 1, 2 and 3 event that was generated, in the order they occurred (oldest first: within the response for binary inputs, and for each point for analogs and counters)
10:57:18.389 - Verify that the response reports each input's present state
10:57:18.389 - Verify that, across every fragment, all event objects come before any static object
10:57:18.389 - Verify that the response holds only objects listed in tables 8-3 and 8-4
10:57:18.389 - Verify that event objects are prefixed with 1-octet (qualifier 0x17) or 2-octet (qualifier 0x28) indexes
10:57:18.389 - Verify that static objects are in start/stop ranges with 1-octet (qualifier 0x00) or 2-octet (qualifier 0x01) indexes
10:57:18.389 - Verify that the flags behave as the note on flags in Section 2 requires (Note 5 in 2.7, Note 6 in 3.1r1).
10:57:18.389 - Verify that each fragment followed by another, or carrying events, asks for an application layer confirmation.
10:57:18.389 - Confirm each response that asks for a confirmation
10:57:18.390 <-P-- 05 64 FF 44 01 00 00 04 53 46
10:57:18.390 41 E1 81 90 00 33 02 07 01 34 40 28 82 A1 01 02 20 0E
10:57:18.390 03 28 0A 00 00 00 81 00 00 01 00 81 00 00 02 00 AC 42
10:57:18.390 81 00 00 03 00 81 00 00 04 00 81 00 00 05 00 81 9B 00
10:57:18.390 00 00 06 00 81 00 00 07 00 81 00 00 08 00 81 00 A9 FA
10:57:18.390 00 09 00 81 00 00 16 01 28 0A 00 00 00 01 01 00 52 4C
10:57:18.390 00 00 01 00 01 01 00 00 00 02 00 01 01 00 00 00 4C 64
10:57:18.390 03 00 01 01 00 00 00 04 00 01 01 00 00 00 05 00 2E 92
10:57:18.390 01 01 00 00 00 06 00 01 01 00 00 00 07 00 01 01 E6 28
10:57:18.390 00 00 00 08 00 01 01 00 00 00 09 00 01 01 00 00 52 BD
10:57:18.390 00 20 01 28 0A 00 00 00 01 64 00 00 00 01 00 01 DC 23
10:57:18.390 64 00 00 00 02 00 01 64 00 00 00 03 00 01 64 00 77 88
10:57:18.390 00 00 04 00 01 64 00 00 00 05 00 01 64 00 00 00 51 FA
10:57:18.390 06 00 01 64 00 00 00 07 00 01 64 00 00 00 08 00 13 BF
10:57:18.390 01 64 00 00 00 09 00 01 64 00 00 00 01 01 01 00 B7 F2
10:57:18.390 00 0B 00 FF 03 0A 02 01 00 00 13 00 01 01 01 01 6E 19
10:57:18.390 01 01 01 01 01 01 01 01 01 01 8D 7B
10:57:18.390 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 255 dest: 1 src: 1024
10:57:18.390 <-T-- fir: 1 fin: 0 seq: 1
10:57:18.390 <-P-- 05 64 BE 44 01 00 00 04 C9 5D
10:57:18.390 82 01 01 01 01 01 01 14 02 01 00 00 09 00 01 01 E3 38
10:57:18.390 00 01 01 00 01 01 00 01 01 00 01 01 00 01 01 00 BA B9
10:57:18.390 01 01 00 01 01 00 01 01 00 01 01 00 15 02 01 00 4B B9
10:57:18.390 00 09 00 01 00 00 01 00 00 01 00 00 01 00 00 01 21 01
10:57:18.390 00 00 01 00 00 01 00 00 01 00 00 01 00 00 01 00 DB 49
10:57:18.390 00 1E 02 01 00 00 09 00 01 64 00 01 64 00 01 64 8E AC
10:57:18.390 00 01 64 00 01 64 00 01 64 00 01 64 00 01 64 00 A3 9A
10:57:18.390 01 64 00 01 64 00 28 02 01 00 00 13 00 01 00 00 C9 DB
10:57:18.390 01 00 00 01 00 00 01 00 00 01 00 00 01 00 00 01 FE 85
10:57:18.390 00 00 01 00 00 01 00 00 01 00 00 01 00 00 01 00 DB 49
10:57:18.390 00 01 00 00 01 00 00 01 00 00 01 00 00 01 00 00 9E 0F
10:57:18.390 01 00 00 01 00 00 01 00 00 61 8D
10:57:18.390 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 190 dest: 1 src: 1024
10:57:18.390 <-T-- fir: 0 fin: 1 seq: 2
10:57:18.392 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
10:57:18.392 g51v2, 1-Byte Count, count: 1
10:57:18.392 time: 1793185038388
10:57:18.392 g2v3, 2-Byte Count and Index, count: 10
10:57:18.392 [0] - flags: 0x81 cto: 0
10:57:18.392 [1] - flags: 0x81 cto: 0
10:57:18.392 [2] - flags: 0x81 cto: 0
10:57:18.392 [3] - flags: 0x81 cto: 0
10:57:18.392 [4] - flags: 0x81 cto: 0
10:57:18.392 [5] - flags: 0x81 cto: 0
10:57:18.392 [6] - flags: 0x81 cto: 0
10:57:18.392 [7] - flags: 0x81 cto: 0
10:57:18.392 [8] - flags: 0x81 cto: 0
10:57:18.392 [9] - flags: 0x81 cto: 0
10:57:18.392 g22v1, 2-Byte Count and Index, count: 10
10:57:18.392 [0] - flags: 0x01 count: 1
10:57:18.392 [1] - flags: 0x01 count: 1
10:57:18.392 [2] - flags: 0x01 count: 1
10:57:18.392 [3] - flags: 0x01 count: 1
10:57:18.392 [4] - flags: 0x01 count: 1
10:57:18.392 [5] - flags: 0x01 count: 1
10:57:18.392 [6] - flags: 0x01 count: 1
10:57:18.392 [7] - flags: 0x01 count: 1
10:57:18.392 [8] - flags: 0x01 count: 1
10:57:18.392 [9] - flags: 0x01 count: 1
10:57:18.392 g32v1, 2-Byte Count and Index, count: 10
10:57:18.392 [0] - flags: 0x01 value: 100
10:57:18.392 [1] - flags: 0x01 value: 100
10:57:18.392 [2] - flags: 0x01 value: 100
10:57:18.392 [3] - flags: 0x01 value: 100
10:57:18.392 [4] - flags: 0x01 value: 100
10:57:18.392 [5] - flags: 0x01 value: 100
10:57:18.392 [6] - flags: 0x01 value: 100
10:57:18.392 [7] - flags: 0x01 value: 100
10:57:18.392 [8] - flags: 0x01 value: 100
10:57:18.392 [9] - flags: 0x01 value: 100
10:57:18.392 g1v1, 2-Byte Start/Stop, start: 0 stop: 11
10:57:18.392 [0] - BooleanValue(true)
10:57:18.392 [1] - BooleanValue(true)
10:57:18.392 [2] - BooleanValue(true)
10:57:18.392 [3] - BooleanValue(true)
10:57:18.392 [4] - BooleanValue(true)
10:57:18.392 [5] - BooleanValue(true)
10:57:18.392 [6] - BooleanValue(true)
10:57:18.392 [7] - BooleanValue(true)
10:57:18.392 [8] - BooleanValue(true)
10:57:18.392 [9] - BooleanValue(true)
10:57:18.392 [10] - BooleanValue(false)
10:57:18.392 [11] - BooleanValue(false)
10:57:18.392 g10v2, 2-Byte Start/Stop, start: 0 stop: 19
10:57:18.392 [0] - flags: 0x01
10:57:18.392 [1] - flags: 0x01
10:57:18.392 [2] - flags: 0x01
10:57:18.392 [3] - flags: 0x01
10:57:18.392 [4] - flags: 0x01
10:57:18.392 [5] - flags: 0x01
10:57:18.392 [6] - flags: 0x01
10:57:18.392 [7] - flags: 0x01
10:57:18.392 [8] - flags: 0x01
10:57:18.392 [9] - flags: 0x01
10:57:18.392 [10] - flags: 0x01
10:57:18.392 [11] - flags: 0x01
10:57:18.392 [12] - flags: 0x01
10:57:18.392 [13] - flags: 0x01
10:57:18.392 [14] - flags: 0x01
10:57:18.392 [15] - flags: 0x01
10:57:18.392 [16] - flags: 0x01
10:57:18.392 [17] - flags: 0x01
10:57:18.392 [18] - flags: 0x01
10:57:18.392 [19] - flags: 0x01
10:57:18.392 g20v2, 2-Byte Start/Stop, start: 0 stop: 9
10:57:18.392 [0] - flags: 0x01 count: 1
10:57:18.392 [1] - flags: 0x01 count: 1
10:57:18.392 [2] - flags: 0x01 count: 1
10:57:18.392 [3] - flags: 0x01 count: 1
10:57:18.392 [4] - flags: 0x01 count: 1
10:57:18.392 [5] - flags: 0x01 count: 1
10:57:18.392 [6] - flags: 0x01 count: 1
10:57:18.392 [7] - flags: 0x01 count: 1
10:57:18.392 [8] - flags: 0x01 count: 1
10:57:18.392 [9] - flags: 0x01 count: 1
10:57:18.392 g21v2, 2-Byte Start/Stop, start: 0 stop: 9
10:57:18.392 [0] - flags: 0x01 count: 0
10:57:18.392 [1] - flags: 0x01 count: 0
10:57:18.392 [2] - flags: 0x01 count: 0
10:57:18.392 [3] - flags: 0x01 count: 0
10:57:18.392 [4] - flags: 0x01 count: 0
10:57:18.392 [5] - flags: 0x01 count: 0
10:57:18.392 [6] - flags: 0x01 count: 0
10:57:18.392 [7] - flags: 0x01 count: 0
10:57:18.392 [8] - flags: 0x01 count: 0
10:57:18.392 [9] - flags: 0x01 count: 0
10:57:18.392 g30v2, 2-Byte Start/Stop, start: 0 stop: 9
10:57:18.392 [0] - flags: 0x01 value: 100
10:57:18.392 [1] - flags: 0x01 value: 100
10:57:18.392 [2] - flags: 0x01 value: 100
10:57:18.392 [3] - flags: 0x01 value: 100
10:57:18.392 [4] - flags: 0x01 value: 100
10:57:18.392 [5] - flags: 0x01 value: 100
10:57:18.392 [6] - flags: 0x01 value: 100
10:57:18.392 [7] - flags: 0x01 value: 100
10:57:18.392 [8] - flags: 0x01 value: 100
10:57:18.392 [9] - flags: 0x01 value: 100
10:57:18.392 g40v2, 2-Byte Start/Stop, start: 0 stop: 19
10:57:18.392 [0] - flags: 0x01 value: 0
10:57:18.392 [1] - flags: 0x01 value: 0
10:57:18.392 [2] - flags: 0x01 value: 0
10:57:18.392 [3] - flags: 0x01 value: 0
10:57:18.392 [4] - flags: 0x01 value: 0
10:57:18.392 [5] - flags: 0x01 value: 0
10:57:18.392 [6] - flags: 0x01 value: 0
10:57:18.392 [7] - flags: 0x01 value: 0
10:57:18.392 [8] - flags: 0x01 value: 0
10:57:18.392 [9] - flags: 0x01 value: 0
10:57:18.392 [10] - flags: 0x01 value: 0
10:57:18.392 [11] - flags: 0x01 value: 0
10:57:18.392 [12] - flags: 0x01 value: 0
10:57:18.392 [13] - flags: 0x01 value: 0
10:57:18.392 [14] - flags: 0x01 value: 0
10:57:18.392 [15] - flags: 0x01 value: 0
10:57:18.392 [16] - flags: 0x01 value: 0
10:57:18.392 [17] - flags: 0x01 value: 0
10:57:18.392 [18] - flags: 0x01 value: 0
10:57:18.392 [19] - flags: 0x01 value: 0
10:57:18.392 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:57:18.392 --T-> fir: 1 fin: 1 seq: 0
10:57:18.392 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
10:57:18.392 --P-> 05 64 08 C4 00 04 01 00 9A 19
10:57:18.392 C0 C1 00 7D 3D
10:57:18.393 [PLG] Verified 30 Class 1, 2 and 3 event(s)
10:57:18.395 [PLG] Verified 82 point(s)
10:57:18.396 Passed procedure: 8.5.5.2.2