8.4.1.2.4 Analog Output, SBO, Execute Issued After Time-out (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

10:56:34.484 Running procedure: 8.4.1.2.4
10:56:34.485 This procedure is enabled because the following options:
10:56:34.485 - supports.analogOutput.commands == true
10:56:34.485 step: 1
10:56:34.485 - Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
10:56:34.485 - g41v2, 1-Byte Count and Index, count: 1
10:56:34.485 - [0] - value: 10 status: 0 (SUCCESS)
10:56:34.485 --A-> Select(0x03) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
10:56:34.485 g41v2, 1-Byte Count and Index, count: 1
10:56:34.485 [0] - value: 10 status: 0 (SUCCESS)
10:56:34.485 --T-> fir: 1 fin: 1 seq: 0
10:56:34.485 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 16 dest: 1024 src: 1
10:56:34.486 --P-> 05 64 10 C4 00 04 01 00 87 FB
10:56:34.486 C0 C0 03 29 02 17 01 00 0A 00 00 9F B0
10:56:34.486 step: 2
10:56:34.486 - Read a single fragment response w/ sequence(0x00)
10:56:34.486 - Verify the response contains the exact object header:
10:56:34.486 - g41v2, 1-Byte Count and Index, count: 1
10:56:34.486 - [0] - value: 10 status: 0 (SUCCESS)
10:56:34.486 - Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
10:56:34.487 <-P-- 05 64 12 44 01 00 00 04 7A 6A
10:56:34.487 C0 C0 81 90 00 29 02 17 01 00 0A 00 00 6A 73
10:56:34.487 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 18 dest: 1 src: 1024
10:56:34.487 <-T-- fir: 1 fin: 1 seq: 0
10:56:34.487 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
10:56:34.487 g41v2, 1-Byte Count and Index, count: 1
10:56:34.487 [0] - value: 10 status: 0 (SUCCESS)
10:56:34.487 step: 3
10:56:34.487 - Wait for 3000 milliseconds
10:56:37.487 step: 4
10:56:37.488 - Operate(0x04) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:56:37.488 - g41v2, 1-Byte Count and Index, count: 1
10:56:37.488 - [0] - value: 10 status: 0 (SUCCESS)
10:56:37.488 - Read a single fragment response w/ sequence(0x01)
10:56:37.488 - Verify the response contains the exact object header:
10:56:37.488 - g41v2, 1-Byte Count and Index, count: 1
10:56:37.488 - [0] - value: 10 status: 1 (TIMEOUT)
10:56:37.488 --A-> Operate(0x04) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
10:56:37.488 g41v2, 1-Byte Count and Index, count: 1
10:56:37.488 [0] - value: 10 status: 0 (SUCCESS)
10:56:37.488 --T-> fir: 1 fin: 1 seq: 0
10:56:37.488 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 16 dest: 1024 src: 1
10:56:37.488 --P-> 05 64 10 C4 00 04 01 00 87 FB
10:56:37.488 C0 C1 04 29 02 17 01 00 0A 00 00 48 F1
10:56:37.488 <-P-- 05 64 12 44 01 00 00 04 7A 6A
10:56:37.488 C1 C1 81 90 00 29 02 17 01 00 0A 00 01 E8 F6
10:56:37.489 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 18 dest: 1 src: 1024
10:56:37.489 <-T-- fir: 1 fin: 1 seq: 1
10:56:37.489 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
10:56:37.489 g41v2, 1-Byte Count and Index, count: 1
10:56:37.489 [0] - value: 10 status: 1 (TIMEOUT)
10:56:37.489 step: 5
10:56:37.489 - Check that no analog control point operated
10:56:38.490 [PLG] Analog output did NOT operate
10:56:38.490 Passed procedure: 8.4.1.2.4