8.4.4 Multiple Object Requests (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

10:56:59.132 Running procedure: 8.4.4
10:56:59.133 This procedure is enabled because the following options:
10:56:59.133 - supports.analogOutput.commands == true
10:56:59.133 step: 1
10:56:59.133 - Device supports up to 4 command objects in a single request
10:56:59.133 step: 2
10:56:59.133 - Sending 4 commands
10:56:59.133 - Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
10:56:59.133 - g41v2, 2-Byte Count and Index, count: 4
10:56:59.133 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.133 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.133 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.133 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.134 --A-> Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
10:56:59.134 g41v2, 2-Byte Count and Index, count: 4
10:56:59.134 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.134 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.134 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.134 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.134 --T-> fir: 1 fin: 1 seq: 0
10:56:59.134 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 33 dest: 1024 src: 1
10:56:59.134 --P-> 05 64 21 C4 00 04 01 00 23 C7
10:56:59.134 C0 C0 03 29 02 28 04 00 0A 00 0A 00 00 0B 00 0A 75 98
10:56:59.134 00 00 0C 00 0A 00 00 0D 00 0A 00 00 D0 44
10:56:59.134 step: 3
10:56:59.134 - Read a single fragment response w/ sequence(0x00)
10:56:59.134 - Verify the response contains the exact object header:
10:56:59.134 - g41v2, 2-Byte Count and Index, count: 4
10:56:59.134 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.134 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.134 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.134 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.134 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
10:56:59.135 <-P-- 05 64 23 44 01 00 00 04 DE 56
10:56:59.135 C0 C0 81 90 00 29 02 28 04 00 0A 00 0A 00 00 0B BF 79
10:56:59.135 00 0A 00 00 0C 00 0A 00 00 0D 00 0A 00 00 8C 99
10:56:59.135 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 35 dest: 1 src: 1024
10:56:59.135 <-T-- fir: 1 fin: 1 seq: 0
10:56:59.135 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
10:56:59.135 g41v2, 2-Byte Count and Index, count: 4
10:56:59.135 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.135 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.135 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.135 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.135 step: 4
10:56:59.135 - Operate(0x04) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:56:59.135 - g41v2, 2-Byte Count and Index, count: 4
10:56:59.135 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.135 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.135 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.135 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.136 --A-> Operate(0x04) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:56:59.136 g41v2, 2-Byte Count and Index, count: 4
10:56:59.136 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.136 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.136 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.136 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.136 --T-> fir: 1 fin: 1 seq: 0
10:56:59.136 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 33 dest: 1024 src: 1
10:56:59.136 --P-> 05 64 21 C4 00 04 01 00 23 C7
10:56:59.136 C0 C1 04 29 02 28 04 00 0A 00 0A 00 00 0B 00 0A BD 4E
10:56:59.136 00 00 0C 00 0A 00 00 0D 00 0A 00 00 D0 44
10:56:59.136 step: 5
10:56:59.136 - Read a single fragment response w/ sequence(0x01)
10:56:59.136 - Verify the response contains the exact object header:
10:56:59.136 - g41v2, 2-Byte Count and Index, count: 4
10:56:59.136 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.136 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.136 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.136 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.136 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
10:56:59.136 <-P-- 05 64 23 44 01 00 00 04 DE 56
10:56:59.136 C1 C1 81 92 00 29 02 28 04 00 0A 00 0A 00 00 0B 5D E4
10:56:59.136 00 0A 00 00 0C 00 0A 00 00 0D 00 0A 00 00 8C 99
10:56:59.136 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 35 dest: 1 src: 1024
10:56:59.136 <-T-- fir: 1 fin: 1 seq: 1
10:56:59.136 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime, Class1Events)
10:56:59.136 g41v2, 2-Byte Count and Index, count: 4
10:56:59.136 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.136 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.136 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.136 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.136 step: 6
10:56:59.136 - Check that analog control point 10 operate
10:56:59.136 - Check that analog control point 11 operate
10:56:59.136 - Check that analog control point 12 operate
10:56:59.136 - Check that analog control point 13 operate
10:56:59.137 [PLG] Analog output 10 did operate
10:56:59.137 [PLG] Analog output 11 did operate
10:56:59.137 [PLG] Analog output 12 did operate
10:56:59.137 [PLG] Analog output 13 did operate
10:56:59.137 step: 7
10:56:59.137 - number of installed points > max commands per request
10:56:59.137 step: 8
10:56:59.137 - Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
10:56:59.137 - g41v2, 2-Byte Count and Index, count: 5
10:56:59.137 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [19] - value: 10 status: 0 (SUCCESS)
10:56:59.137 --A-> Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
10:56:59.137 g41v2, 2-Byte Count and Index, count: 5
10:56:59.137 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.137 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.137 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.137 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.137 [19] - value: 10 status: 0 (SUCCESS)
10:56:59.137 --T-> fir: 1 fin: 1 seq: 0
10:56:59.137 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 38 dest: 1024 src: 1
10:56:59.137 --P-> 05 64 26 C4 00 04 01 00 1D 19
10:56:59.137 C0 C2 03 29 02 28 05 00 0A 00 0A 00 00 0B 00 0A 27 87
10:56:59.137 00 00 0C 00 0A 00 00 0D 00 0A 00 00 13 00 0A 00 47 82
10:56:59.137 00 FF FF
10:56:59.137 step: 9
10:56:59.137 - Read a single fragment response w/ sequence(0x02)
10:56:59.137 - Verify the response contains the exact object header:
10:56:59.137 - g41v2, 2-Byte Count and Index, count: 5
10:56:59.137 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.137 - [19] - value: 10 status: 8 (TOO_MANY_OPS)
10:56:59.137 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
10:56:59.137 <-P-- 05 64 28 44 01 00 00 04 52 5F
10:56:59.137 C2 C2 81 92 00 29 02 28 05 00 0A 00 0A 00 00 0B F3 96
10:56:59.137 00 0A 00 00 0C 00 0A 00 00 0D 00 0A 00 00 13 00 C8 68
10:56:59.137 0A 00 08 C6 FE
10:56:59.137 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 40 dest: 1 src: 1024
10:56:59.137 <-T-- fir: 1 fin: 1 seq: 2
10:56:59.138 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime, Class1Events)
10:56:59.138 g41v2, 2-Byte Count and Index, count: 5
10:56:59.138 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [19] - value: 10 status: 8 (TOO_MANY_OPS)
10:56:59.138 step: 10
10:56:59.138 - Devices that support control operations must support direct operate
10:56:59.138 step: 11
10:56:59.138 - Direct Operate(0x05) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
10:56:59.138 - g41v2, 2-Byte Count and Index, count: 5
10:56:59.138 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [19] - value: 10 status: 0 (SUCCESS)
10:56:59.138 --A-> Direct Operate(0x05) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
10:56:59.138 g41v2, 2-Byte Count and Index, count: 5
10:56:59.138 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [19] - value: 10 status: 0 (SUCCESS)
10:56:59.138 --T-> fir: 1 fin: 1 seq: 0
10:56:59.138 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 38 dest: 1024 src: 1
10:56:59.138 --P-> 05 64 26 C4 00 04 01 00 1D 19
10:56:59.138 C0 C3 05 29 02 28 05 00 0A 00 0A 00 00 0B 00 0A 1F 6F
10:56:59.138 00 00 0C 00 0A 00 00 0D 00 0A 00 00 13 00 0A 00 47 82
10:56:59.138 00 FF FF
10:56:59.138 step: 12
10:56:59.138 - Read a single fragment response w/ sequence(0x03)
10:56:59.138 - Verify the response contains the exact object header:
10:56:59.138 - g41v2, 2-Byte Count and Index, count: 5
10:56:59.138 - [10] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [11] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [12] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [13] - value: 10 status: 0 (SUCCESS)
10:56:59.138 - [19] - value: 10 status: 8 (TOO_MANY_OPS)
10:56:59.138 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
10:56:59.138 - Check that analog control point 10 operate
10:56:59.138 - Check that analog control point 11 operate
10:56:59.138 - Check that analog control point 12 operate
10:56:59.138 - Check that analog control point 13 operate
10:56:59.138 - Not verified by this tool: that the last point, refused with status 8, didn't operate
10:56:59.138 <-P-- 05 64 28 44 01 00 00 04 52 5F
10:56:59.138 C3 C3 81 92 00 29 02 28 05 00 0A 00 0A 00 00 0B 67 B5
10:56:59.138 00 0A 00 00 0C 00 0A 00 00 0D 00 0A 00 00 13 00 C8 68
10:56:59.138 0A 00 08 C6 FE
10:56:59.138 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 40 dest: 1 src: 1024
10:56:59.138 <-T-- fir: 1 fin: 1 seq: 3
10:56:59.138 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime, Class1Events)
10:56:59.138 g41v2, 2-Byte Count and Index, count: 5
10:56:59.138 [10] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [11] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [12] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [13] - value: 10 status: 0 (SUCCESS)
10:56:59.138 [19] - value: 10 status: 8 (TOO_MANY_OPS)
10:56:59.138 [PLG] Analog output 10 did operate
10:56:59.138 [PLG] Analog output 11 did operate
10:56:59.138 [PLG] Analog output 12 did operate
10:56:59.138 [PLG] Analog output 13 did operate
10:56:59.139 step: 13
10:56:59.139 - Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
10:56:59.139 - g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 - [0] - value: 10 status: 0 (SUCCESS)
10:56:59.139 - g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 - [65535] - value: 10 status: 0 (SUCCESS)
10:56:59.139 --A-> Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04
10:56:59.139 g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 [0] - value: 10 status: 0 (SUCCESS)
10:56:59.139 g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 [65535] - value: 10 status: 0 (SUCCESS)
10:56:59.139 --T-> fir: 1 fin: 1 seq: 0
10:56:59.139 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 28 dest: 1024 src: 1
10:56:59.139 --P-> 05 64 1C C4 00 04 01 00 35 2C
10:56:59.139 C0 C4 03 29 02 28 01 00 00 00 0A 00 00 29 02 28 B4 65
10:56:59.139 01 00 FF FF 0A 00 00 90 8C
10:56:59.139 step: 14
10:56:59.139 - Read a single fragment response w/ sequence(0x04)
10:56:59.139 - Verify that the IIN field contains IIN(ParamError)
10:56:59.139 - Verify the response contains the exact object headers:
10:56:59.139 - g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 - [0] - value: 10 status: 0 (SUCCESS)
10:56:59.139 - g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 - [65535] - value: 10 status: 4 (NOT_SUPPORTED)
10:56:59.139 <-P-- 05 64 1E 44 01 00 00 04 C8 BD
10:56:59.139 C4 C4 81 92 04 29 02 28 01 00 00 00 0A 00 00 29 AC 9A
10:56:59.139 02 28 01 00 FF FF 0A 00 04 31 4D
10:56:59.139 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 30 dest: 1 src: 1024
10:56:59.139 <-T-- fir: 1 fin: 1 seq: 4
10:56:59.139 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x04 IIN(DeviceRestart, NeedTime, Class1Events, ParamError)
10:56:59.139 g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 [0] - value: 10 status: 0 (SUCCESS)
10:56:59.139 g41v2, 2-Byte Count and Index, count: 1
10:56:59.139 [65535] - value: 10 status: 4 (NOT_SUPPORTED)
10:56:59.139 Passed procedure: 8.4.4