05:25:51.884		Running procedure: 8.7.2
05:25:51.886		This procedure is enabled because the following options:
05:25:51.886		- timesync.supportSynchronizingTimeFromMaster == true
05:25:51.886		- timesync.supportLanTimeSync == true
05:25:51.886		step: 1
05:25:51.886		- Cycle power to the DUT
05:25:51.886	[PLG]	Cycling power
05:25:51.887		step: 2
05:25:51.887		- Wait for 5000 milliseconds
05:25:56.887		step: 3
05:25:56.887		- Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:25:56.887		- g60v2, All Objects
05:25:56.887	--A->	Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:25:56.887		g60v2, All Objects
05:25:56.888	--T->	fir: 1 fin: 1 seq: 0
05:25:56.888	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 11 dest: 1024 src: 1
05:25:56.888	--P->	05 64 0B C4 00 04 01 00 CA 8A
05:25:56.888		C0 C0 01 3C 02 06 54 E0
05:25:56.888		step: 4
05:25:56.888		- Read any number of valid responses beginning w/ sequence(0x00) and incrementing by 1 modulo 16
05:25:56.888		- Verify that the IIN field contains IIN(NeedTime)
05:25:56.888		- Verify that each fragment followed by another, or carrying events, asks for an application layer confirmation.
05:25:56.888		- Confirm each response that asks for a confirmation
05:25:56.889	<-P--	05 64 0A 44 01 00 00 04 67 88
05:25:56.889		C0 C0 81 90 00 9B 2C
05:25:56.889	<-L--	master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:25:56.889	<-T--	fir: 1 fin: 1 seq: 0
05:25:56.889	<-A--	Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
05:25:56.889		steps: 5 to 6
05:25:56.889		- Broadcast a Record Current Time request (function code 24) to 0xFFFF, and note when it's been sent
05:25:56.889	--A->	Record Current Time(0x18) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:25:56.889	--T->	fir: 1 fin: 1 seq: 0
05:25:56.889	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 65535 src: 1
05:25:56.889	--P->	05 64 08 C4 FF FF 01 00 CF 9C
05:25:56.889		C0 C1 18 9F 70
05:25:56.889		step: 7
05:25:56.889		- Verify that no link layer frames are received within 2000 ms
05:25:58.892		frame receive timeout
05:25:58.892		step: 8
05:25:58.892		- Wait for 5000 milliseconds
05:26:03.892		step: 9
05:26:03.892		- Write the time the Record Current Time request was sent (g50v3, qualifier 0x07) w/ sequence(0x02)
05:26:03.893	--A->	Write(0x02) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:26:03.893		g50v3, 1-Byte Count, count: 1
05:26:03.893		time: 1793251556889
05:26:03.893	--T->	fir: 1 fin: 1 seq: 0
05:26:03.893	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 18 dest: 1024 src: 1
05:26:03.893	--P->	05 64 12 C4 00 04 01 00 30 DD
05:26:03.893		C0 C2 02 32 03 07 01 19 3E 1F 86 A1 01 58 2E
05:26:03.893		steps: 10 to 11
05:26:03.893		- Read a single fragment response w/ sequence(0x02)
05:26:03.893		- Verify that the response is empty
05:26:03.893		- Verify that the IIN field does not contain bits IIN(ParamError, ObjectUnknown, FuncNotSupported)
05:26:03.893		- Verify that the IIN field contains IIN(Broadcast)
05:26:03.893		- Verify that the IIN field does not contain bits IIN(NeedTime)
05:26:03.893		- Confirm each response that asks for a confirmation
05:26:03.894	<-P--	05 64 0A 44 01 00 00 04 67 88
05:26:03.894		C1 C2 81 81 00 52 B3
05:26:03.894	<-L--	master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 10 dest: 1 src: 1024
05:26:03.894	<-T--	fir: 1 fin: 1 seq: 1
05:26:03.894	<-A--	Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02 IIN(DeviceRestart, Broadcast)
05:26:03.894		step: 12
05:26:03.894		- Trigger an event of a supported timestamped type, recording when it occurs for the timestamp check
05:26:03.894	[PLG]	Updated BI 0: value=true, flags=81, timestamp=1793251563892 (SYNCHRONIZED_TIME)
05:26:03.894		step: 13
05:26:03.894		- Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:26:03.894		- g60v2, All Objects
05:26:03.894		- g60v3, All Objects
05:26:03.894		- g60v4, All Objects
05:26:03.894	--A->	Read(0x01) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:26:03.894		g60v2, All Objects
05:26:03.894		g60v3, All Objects
05:26:03.894		g60v4, All Objects
05:26:03.894	--T->	fir: 1 fin: 1 seq: 0
05:26:03.894	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 17 dest: 1024 src: 1
05:26:03.894	--P->	05 64 11 C4 00 04 01 00 60 4E
05:26:03.894		C0 C3 01 3C 02 06 3C 03 06 3C 04 06 0C 0B
05:26:03.895		step: 14
05:26:03.895		- Read any number of valid responses beginning w/ sequence(0x03) and incrementing by 1 modulo 16
05:26:03.895		- Verify that each fragment followed by another, or carrying events, asks for an application layer confirmation.
05:26:03.895		- Verify that the response holds an event that carries its time
05:26:03.895		- Verify that the generated event is in the response and that its timestamp's error from the known event time does not exceed the Device Profile's tolerance
05:26:03.895		- Confirm each response that asks for a confirmation
05:26:03.895	<-P--	05 64 18 44 01 00 00 04 11 D6
05:26:03.895		C2 E3 81 80 00 02 02 28 01 00 00 00 81 74 59 1F 61 53
05:26:03.895		86 A1 01 DE 8A
05:26:03.895	<-L--	master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 24 dest: 1 src: 1024
05:26:03.895	<-T--	fir: 1 fin: 1 seq: 2
05:26:03.895	<-A--	Response(0x81) fir: 1 fin: 1 con: 1 uns: 0 seq: 0x03 IIN(DeviceRestart)
05:26:03.895		g2v2, 2-Byte Count and Index, count: 1
05:26:03.895		[0] - flags: 0x81 time: 1793251563892
05:26:03.895	--A->	Confirm(0x00) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x03
05:26:03.895	--T->	fir: 1 fin: 1 seq: 0
05:26:03.895	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:26:03.895	--P->	05 64 08 C4 00 04 01 00 9A 19
05:26:03.895		C0 C3 00 98 26
05:26:03.895	[PLG]	Verified 1 Class 1, 2 and 3 event(s)
05:26:03.895		Passed procedure: 8.7.2