12:02:23.971 Running procedure: 8.22.2.9
12:02:23.975 This procedure is enabled because the following options:
12:02:23.975 - supports.doubleBitChangeEvents == true
12:02:23.976 step: 1
12:02:23.976 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
12:02:23.976 - g4v0, All Objects
12:02:23.978 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
12:02:23.978 g4v0, All Objects
12:02:23.978 --T-> fir: 1 fin: 1 seq: 0
12:02:23.979 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:02:23.979 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:02:23.979 C0 C1 01 04 00 06 05 23
12:02:23.981 steps: 2 to 3
12:02:23.981 - Read a single fragment response w/ sequence(0x01)
12:02:23.981 - If the response is not Null, verify that the device requests an application layer confirmation.
12:02:23.982 <-P-- 05 64 0A 44 01 00 00 04 67 88
12:02:23.982 C0 C1 81 90 00 73 EE
12:02:23.982 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
12:02:23.982 <-T-- fir: 1 fin: 1 seq: 0
12:02:23.983 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
12:02:23.983 step: 4
12:02:23.983 - Generate several Double-bit Binary Input Change Events
12:02:23.984 Updated DBBI 41: value=DETERMINED_OFF, flags=41, timestamp=DNPTime(1586534543983)
12:02:23.984 Updated DBBI 1024: value=DETERMINED_ON, flags=81, timestamp=DNPTime(1586534543984)
12:02:23.984 Updated DBBI 41: value=DETERMINED_ON, flags=81, timestamp=DNPTime(1586534543984)
12:02:23.985 step: 5
12:02:23.985 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:02:23.985 - g4v2, All Objects
12:02:23.986 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:02:23.986 g4v2, All Objects
12:02:23.986 --T-> fir: 1 fin: 1 seq: 0
12:02:23.986 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:02:23.987 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:02:23.987 C0 C2 01 04 02 06 EA 5D
12:02:23.988 step: 6
12:02:23.988 - DUT supports Binary Input Change with Time events.
12:02:23.991 steps: 7 to 12
12:02:23.991 - Read a single fragment response w/ sequence(0x02)
12:02:23.991 - Verify the device responds with all generated Double-bit Binary events
12:02:23.991 - If the variation contains timestamps, verify that they are reasonable according to the resolution specified in the Device Profile
12:02:23.991 - Verify that an application layer confirmation is requested.
12:02:23.991 - Verify that the response contains only g4v2.
12:02:23.991 - Verify that the data is reported using 8 bit indexing (qualifier 0x17) or 16 bit indexing (qualifier 0x28).
12:02:23.991 - Verify that flag behavior complies with Section 2, Note #5.
12:02:23.991 <-P-- 05 64 2A 44 01 00 00 04 E5 79
12:02:23.991 C1 E2 81 90 00 04 02 28 03 00 29 00 41 6F F2 D3 69 77
12:02:23.991 64 71 01 00 04 81 70 F2 D3 64 71 01 29 00 81 70 CD 45
12:02:23.991 F2 D3 64 71 01 18 ED
12:02:23.991 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 42 dest: 1 src: 1024
12:02:23.991 <-T-- fir: 1 fin: 1 seq: 1
12:02:23.993 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
12:02:23.993 g4v2, 2-Byte Count and Index, count: 3
12:02:23.993 [41] - flags: 0x41 time: 1586534543983
12:02:23.993 [1024] - flags: 0x81 time: 1586534543984
12:02:23.993 [41] - flags: 0x81 time: 1586534543984
12:02:23.993 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
12:02:23.993 --T-> fir: 1 fin: 1 seq: 0
12:02:23.994 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
12:02:23.994 --P-> 05 64 08 C4 00 04 01 00 9A 19
12:02:23.994 C0 C2 00 D6 8D
12:02:23.995 step: 13
12:02:23.995 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
12:02:23.995 - g4v0, All Objects
12:02:23.996 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
12:02:23.996 g4v0, All Objects
12:02:23.996 --T-> fir: 1 fin: 1 seq: 0
12:02:23.997 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
12:02:23.997 --P-> 05 64 0B C4 00 04 01 00 CA 8A
12:02:23.997 C0 C3 01 04 00 06 09 65
12:02:23.998 step: 14
12:02:23.998 - Read a single fragment response w/ sequence(0x03)
12:02:23.998 - Verify that the response is empty
12:02:23.999 <-P-- 05 64 0A 44 01 00 00 04 67 88
12:02:23.999 C2 C3 81 90 00 D6 60
12:02:23.999 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
12:02:23.999 <-T-- fir: 1 fin: 1 seq: 2
12:02:24.000 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime)
12:02:24.000 Passed procedure: 8.22.2.9