8.6.6.2.1 Buffer Overflow, Binary Input Change Event Buffers (revision 3.1r1, subset level 3)

Device under test: Step Function I/O dnp3 outstation

05:25:45.427 Running procedure: 8.6.6.2.1
05:25:45.430 This procedure is enabled because the following options:
05:25:45.430 - supports.binaryInput == true
05:25:45.430 - supports.binaryInputChangeEvents == true
05:25:45.430 step: 1
05:25:45.430 - Skipped for a device without Binary Input Change Events
05:25:45.430 step: 2
05:25:45.430 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:25:45.430 - g60v2, All Objects
05:25:45.430 - g60v3, All Objects
05:25:45.430 - g60v4, All Objects
05:25:45.430 - Read any number of valid responses beginning w/ sequence(0x00) and incrementing by 1 modulo 16
05:25:45.430 - If the response carries data, verify that it asks for an application layer confirmation.
05:25:45.430 - Confirm each response that asks for a confirmation
05:25:45.431 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:25:45.431 g60v2, All Objects
05:25:45.431 g60v3, All Objects
05:25:45.431 g60v4, All Objects
05:25:45.431 --T-> fir: 1 fin: 1 seq: 0
05:25:45.431 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 17 dest: 1024 src: 1
05:25:45.431 --P-> 05 64 11 C4 00 04 01 00 60 4E
05:25:45.431 C0 C0 01 3C 02 06 3C 03 06 3C 04 06 9E 30
05:25:45.432 <-P-- 05 64 0A 44 01 00 00 04 67 88
05:25:45.432 C0 C0 81 90 00 9B 2C
05:25:45.432 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:25:45.432 <-T-- fir: 1 fin: 1 seq: 0
05:25:45.432 <-A-- Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
05:25:45.432 step: 3
05:25:45.432 - Generate 200 Binary Input Change Event(s)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545432 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.433 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.434 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545433 (UNSYNCHRONIZED_TIME)
05:25:45.434 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545434 (UNSYNCHRONIZED_TIME)
05:25:45.434 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545434 (UNSYNCHRONIZED_TIME)
05:25:45.434 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545434 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545434 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.435 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545435 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.436 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545436 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.437 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545437 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.438 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545438 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.439 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545439 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.440 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545440 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.441 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545441 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.442 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545442 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 [PLG] Updated BI 0: value=false, flags=1, timestamp=1793251545443 (UNSYNCHRONIZED_TIME)
05:25:45.443 The plugin reports the DUT's clock unsynchronized
05:25:45.444 step: 4
05:25:45.444 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:25:45.444 - g60v2, All Objects
05:25:45.444 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:25:45.444 g60v2, All Objects
05:25:45.444 --T-> fir: 1 fin: 1 seq: 0
05:25:45.444 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:25:45.444 --P-> 05 64 0B C4 00 04 01 00 CA 8A
05:25:45.444 C0 C1 01 3C 02 06 52 C3
05:25:45.444 step: 5
05:25:45.444 - Read one fragment of the response w/ sequence(0x01)
05:25:45.444 - Verify that this is the first fragment of the response (FIR set)
05:25:45.444 - Verify that the IIN field does not contain bits IIN(EventBufferOverflow)
05:25:45.445 <-P-- 05 64 FF 44 01 00 00 04 53 46
05:25:45.445 41 E1 81 90 00 33 02 07 01 58 11 1F 86 A1 01 02 F4 A9
05:25:45.445 03 28 C8 00 00 00 81 00 00 00 00 01 01 00 00 00 5A B3
05:25:45.445 81 01 00 00 00 01 01 00 00 00 81 01 00 00 00 01 B7 8F
05:25:45.445 01 00 00 00 81 01 00 00 00 01 01 00 00 00 81 01 E7 2F
05:25:45.445 00 00 00 01 01 00 00 00 81 01 00 00 00 01 01 00 14 98
05:25:45.445 00 00 81 01 00 00 00 01 01 00 00 00 81 01 00 00 4A 08
05:25:45.445 00 01 02 00 00 00 81 02 00 00 00 01 02 00 00 00 ED FD
05:25:45.445 81 02 00 00 00 01 03 00 00 00 81 03 00 00 00 01 2E B0
05:25:45.445 03 00 00 00 81 03 00 00 00 01 03 00 00 00 81 03 E8 D3
05:25:45.445 00 00 00 01 03 00 00 00 81 03 00 00 00 01 03 00 82 A9
05:25:45.445 00 00 81 03 00 00 00 01 03 00 00 00 81 03 00 00 68 A9
05:25:45.445 00 01 03 00 00 00 81 03 00 00 00 01 03 00 00 00 34 DF
05:25:45.445 81 03 00 00 00 01 03 00 00 00 81 04 00 00 00 01 24 37
05:25:45.445 04 00 00 00 81 04 00 00 00 01 04 00 00 00 81 04 3B 42
05:25:45.445 00 00 00 01 04 00 00 00 81 04 00 00 00 01 04 00 F3 E3
05:25:45.445 00 00 81 04 00 00 00 01 04 00 DF D8
05:25:45.445 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 255 dest: 1 src: 1024
05:25:45.445 <-T-- fir: 1 fin: 0 seq: 1
05:25:45.446 <-P-- 05 64 FF 44 01 00 00 04 53 46
05:25:45.446 02 00 00 81 04 00 00 00 01 04 00 00 00 81 04 00 32 D2
05:25:45.446 00 00 01 04 00 00 00 81 04 00 00 00 01 04 00 00 12 D9
05:25:45.446 00 81 04 00 00 00 01 04 00 00 00 81 04 00 00 00 EB 84
05:25:45.446 01 04 00 00 00 81 04 00 00 00 01 05 00 00 00 81 4D 60
05:25:45.446 05 00 00 00 01 05 00 00 00 81 05 00 00 00 01 05 A7 76
05:25:45.446 00 00 00 81 05 00 00 00 01 05 00 00 00 81 05 00 E1 51
05:25:45.446 00 00 01 05 00 00 00 81 05 00 00 00 01 05 00 00 83 89
05:25:45.446 00 81 05 00 00 00 01 05 00 00 00 81 05 00 00 00 32 A6
05:25:45.446 01 05 00 00 00 81 05 00 00 00 01 05 00 00 00 81 37 CD
05:25:45.446 05 00 00 00 01 05 00 00 00 81 05 00 00 00 01 05 A7 76
05:25:45.446 00 00 00 81 05 00 00 00 01 06 00 00 00 81 06 00 EC 00
05:25:45.446 00 00 01 06 00 00 00 81 06 00 00 00 01 06 00 00 30 78
05:25:45.446 00 81 06 00 00 00 01 06 00 00 00 81 06 00 00 00 59 C1
05:25:45.446 01 06 00 00 00 81 06 00 00 00 01 06 00 00 00 81 CA 12
05:25:45.446 06 00 00 00 01 06 00 00 00 81 06 00 00 00 01 06 13 52
05:25:45.446 00 00 00 81 06 00 00 00 01 06 81 29
05:25:45.446 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 255 dest: 1 src: 1024
05:25:45.446 <-T-- fir: 0 fin: 0 seq: 2
05:25:45.446 <-P-- 05 64 FF 44 01 00 00 04 53 46
05:25:45.446 03 00 00 00 81 06 00 00 00 01 06 00 00 00 81 06 F1 88
05:25:45.446 00 00 00 01 06 00 00 00 81 06 00 00 00 01 07 00 2B 79
05:25:45.446 00 00 81 07 00 00 00 01 07 00 00 00 81 07 00 00 55 A6
05:25:45.446 00 01 07 00 00 00 81 07 00 00 00 01 07 00 00 00 50 54
05:25:45.446 81 07 00 00 00 01 07 00 00 00 81 07 00 00 00 01 34 7D
05:25:45.446 07 00 00 00 81 07 00 00 00 01 07 00 00 00 81 07 8F 66
05:25:45.446 00 00 00 01 07 00 00 00 81 07 00 00 00 01 07 00 AE CA
05:25:45.446 00 00 81 07 00 00 00 01 07 00 00 00 81 07 00 00 55 A6
05:25:45.446 00 01 07 00 00 00 81 08 00 00 00 01 08 00 00 00 C7 E1
05:25:45.446 81 08 00 00 00 01 08 00 00 00 81 08 00 00 00 01 B6 0A
05:25:45.446 08 00 00 00 81 08 00 00 00 01 08 00 00 00 81 08 EB D0
05:25:45.446 00 00 00 01 08 00 00 00 81 08 00 00 00 01 08 00 87 46
05:25:45.446 00 00 81 08 00 00 00 01 08 00 00 00 81 08 00 00 A1 46
05:25:45.446 00 01 08 00 00 00 81 08 00 00 00 01 08 00 00 00 EE E3
05:25:45.446 81 08 00 00 00 01 08 00 00 00 81 08 00 00 00 01 B6 0A
05:25:45.446 08 00 00 00 81 08 00 00 00 01 F3 C1
05:25:45.446 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 255 dest: 1 src: 1024
05:25:45.446 <-T-- fir: 0 fin: 0 seq: 3
05:25:45.447 <-P-- 05 64 FF 44 01 00 00 04 53 46
05:25:45.447 04 08 00 00 00 81 09 00 00 00 01 09 00 00 00 81 95 3D
05:25:45.447 09 00 00 00 01 09 00 00 00 81 09 00 00 00 01 09 77 E4
05:25:45.447 00 00 00 81 09 00 00 00 01 09 00 00 00 81 09 00 95 F4
05:25:45.447 00 00 01 09 00 00 00 81 09 00 00 00 01 09 00 00 C4 98
05:25:45.447 00 81 09 00 00 00 01 09 00 00 00 81 09 00 00 00 E7 76
05:25:45.447 01 09 00 00 00 81 09 00 00 00 01 09 00 00 00 81 48 65
05:25:45.447 0A 00 00 00 01 0A 00 00 00 81 0A 00 00 00 01 0A C3 C0
05:25:45.447 00 00 00 81 0A 00 00 00 01 0A 00 00 00 81 0A 00 C8 DD
05:25:45.447 00 00 01 0A 00 00 00 81 0A 00 00 00 01 0A 00 00 77 69
05:25:45.447 00 81 0A 00 00 00 01 0A 00 00 00 81 0A 00 00 00 8C 11
05:25:45.447 01 0A 00 00 00 81 0A 00 00 00 01 0A 00 00 00 81 B5 BA
05:25:45.447 0A 00 00 00 01 0A 00 00 00 81 0A 00 00 00 01 0A C3 C0
05:25:45.447 00 00 00 81 0A 00 00 00 01 0A 00 00 00 81 0B 00 86 76
05:25:45.447 00 00 01 0B 00 00 00 81 0B 00 00 00 01 0B 00 00 E6 39
05:25:45.447 00 81 0B 00 00 00 01 0B 00 00 00 81 0B 00 00 00 55 33
05:25:45.447 01 0B 00 00 00 81 0B 00 00 00 DC BB
05:25:45.447 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 255 dest: 1 src: 1024
05:25:45.447 <-T-- fir: 0 fin: 0 seq: 4
05:25:45.447 <-P-- 05 64 1D 44 01 00 00 04 98 2E
05:25:45.447 85 01 0B 00 00 00 81 0B 00 00 00 01 0B 00 00 00 4C 85
05:25:45.447 81 0B 00 00 00 01 0B 00 9F 80
05:25:45.447 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 29 dest: 1 src: 1024
05:25:45.447 <-T-- fir: 0 fin: 1 seq: 5
05:25:45.450 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
05:25:45.450 g51v2, 1-Byte Count, count: 1
05:25:45.450 time: 1793251545432
05:25:45.450 g2v3, 2-Byte Count and Index, count: 200
05:25:45.450 [0] - flags: 0x81 cto: 0
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 1
05:25:45.450 [0] - flags: 0x81 cto: 1
05:25:45.450 [0] - flags: 0x01 cto: 2
05:25:45.450 [0] - flags: 0x81 cto: 2
05:25:45.450 [0] - flags: 0x01 cto: 2
05:25:45.450 [0] - flags: 0x81 cto: 2
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 3
05:25:45.450 [0] - flags: 0x01 cto: 3
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 4
05:25:45.450 [0] - flags: 0x81 cto: 4
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 5
05:25:45.450 [0] - flags: 0x81 cto: 5
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 6
05:25:45.450 [0] - flags: 0x81 cto: 6
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 7
05:25:45.450 [0] - flags: 0x01 cto: 7
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 8
05:25:45.450 [0] - flags: 0x01 cto: 8
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 9
05:25:45.450 [0] - flags: 0x01 cto: 9
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 10
05:25:45.450 [0] - flags: 0x01 cto: 10
05:25:45.450 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 [0] - flags: 0x81 cto: 11
05:25:45.451 [0] - flags: 0x01 cto: 11
05:25:45.451 step: 6
05:25:45.451 - Generate 1 Binary Input Change Event(s)
05:25:45.451 [PLG] Updated BI 0: value=true, flags=81, timestamp=1793251545451 (UNSYNCHRONIZED_TIME)
05:25:45.451 The plugin reports the DUT's clock unsynchronized
05:25:45.451 step: 7
05:25:45.451 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:25:45.451 - g60v2, 1-Byte Count, count: 1
05:25:45.451 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:25:45.451 g60v2, 1-Byte Count, count: 1
05:25:45.451 --T-> fir: 1 fin: 1 seq: 0
05:25:45.451 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 12 dest: 1024 src: 1
05:25:45.451 --P-> 05 64 0C C4 00 04 01 00 F4 54
05:25:45.451 C0 C2 01 3C 02 07 01 3F 6E
05:25:45.451 steps: 8 to 9
05:25:45.451 - Read a single fragment response w/ sequence(0x02)
05:25:45.451 - Verify that the response contains a single Binary Input Change Event
05:25:45.451 - Verify that the IIN field contains IIN(EventBufferOverflow)
05:25:45.451 - Verify that an application layer confirmation is requested.
05:25:45.451 - Confirm each response that asks for a confirmation
05:25:45.451 <-P-- 05 64 1E 44 01 00 00 04 C8 BD
05:25:45.451 C6 E2 81 92 08 33 02 07 01 59 11 1F 86 A1 01 02 37 A8
05:25:45.451 03 28 01 00 00 00 01 00 00 3D 7F
05:25:45.451 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 30 dest: 1 src: 1024
05:25:45.451 <-T-- fir: 1 fin: 1 seq: 6
05:25:45.452 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime, Class1Events, EventBufferOverflow)
05:25:45.452 g51v2, 1-Byte Count, count: 1
05:25:45.452 time: 1793251545433
05:25:45.452 g2v3, 2-Byte Count and Index, count: 1
05:25:45.452 [0] - flags: 0x01 cto: 0
05:25:45.452 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:25:45.452 --T-> fir: 1 fin: 1 seq: 0
05:25:45.452 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:25:45.452 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:25:45.452 C0 C2 00 D6 8D
05:25:45.452 step: 10
05:25:45.452 - Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:25:45.452 - g60v2, 1-Byte Count, count: 1
05:25:45.452 --A-> Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:25:45.452 g60v2, 1-Byte Count, count: 1
05:25:45.452 --T-> fir: 1 fin: 1 seq: 0
05:25:45.452 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 12 dest: 1024 src: 1
05:25:45.452 --P-> 05 64 0C C4 00 04 01 00 F4 54
05:25:45.452 C0 C3 01 3C 02 07 01 D8 DB
05:25:45.452 steps: 11 to 12
05:25:45.452 - Read a single fragment response w/ sequence(0x03)
05:25:45.452 - Verify that the response contains a single Binary Input Change Event
05:25:45.452 - Verify that the IIN field does not contain bits IIN(EventBufferOverflow)
05:25:45.452 - Verify that an application layer confirmation is requested.
05:25:45.452 - Confirm each response that asks for a confirmation
05:25:45.453 <-P-- 05 64 1E 44 01 00 00 04 C8 BD
05:25:45.453 C7 E3 81 92 00 33 02 07 01 59 11 1F 86 A1 01 02 8D 43
05:25:45.453 03 28 01 00 00 00 81 00 00 9A 2A
05:25:45.453 <-L-- master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 30 dest: 1 src: 1024
05:25:45.453 <-T-- fir: 1 fin: 1 seq: 7
05:25:45.453 <-A-- Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart, NeedTime, Class1Events)
05:25:45.453 g51v2, 1-Byte Count, count: 1
05:25:45.453 time: 1793251545433
05:25:45.453 g2v3, 2-Byte Count and Index, count: 1
05:25:45.453 [0] - flags: 0x81 cto: 0
05:25:45.453 --A-> Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:25:45.453 --T-> fir: 1 fin: 1 seq: 0
05:25:45.453 --L-> master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:25:45.453 --P-> 05 64 08 C4 00 04 01 00 9A 19
05:25:45.453 C0 C3 00 98 26
05:25:45.454 Passed procedure: 8.6.6.2.1