05:25:56.188		Running procedure: 8.7.1.2
05:25:56.190		This procedure is enabled because the following options:
05:25:56.190		- timesync.supportSynchronizingTimeFromMaster == true
05:25:56.190		step: 1
05:25:56.190		- Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:25:56.190	--A->	Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00
05:25:56.190	--T->	fir: 1 fin: 1 seq: 0
05:25:56.190	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:25:56.190	--P->	05 64 08 C4 00 04 01 00 9A 19
05:25:56.190		C0 C0 17 C2 A7
05:25:56.190		steps: 2 to 3
05:25:56.190		- Read a single fragment response w/ sequence(0x00)
05:25:56.190		- Verify that the response is one g52v2 object (qualifier 0x07, count 1) carrying the measured delay in milliseconds
05:25:56.190		- Verify that the delay measurement error does not exceed the Device Profile's tolerance
05:25:56.191	<-P--	05 64 10 44 01 00 00 04 CD 4C
05:25:56.191		C0 C0 81 90 00 34 02 07 01 00 00 CB 3E
05:25:56.191	<-L--	master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 16 dest: 1 src: 1024
05:25:56.191	<-T--	fir: 1 fin: 1 seq: 0
05:25:56.192	<-A--	Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x00 IIN(DeviceRestart, NeedTime)
05:25:56.192		g52v2, 1-Byte Count, count: 1
05:25:56.192		delay: 0
05:25:56.192	[PLG]	Delay measurement is within acceptable range (+/- 0)
05:25:56.192		step: 4
05:25:56.192		- Measure the delay two more times
05:25:56.192		- Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:25:56.192		- Read a single fragment response w/ sequence(0x01)
05:25:56.192		- Verify that the response is one g52v2 object (qualifier 0x07, count 1) carrying the measured delay in milliseconds
05:25:56.192		- Verify that the delay measurement error does not exceed the Device Profile's tolerance
05:25:56.192		- Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:25:56.192		- Read a single fragment response w/ sequence(0x02)
05:25:56.192		- Verify that the response is one g52v2 object (qualifier 0x07, count 1) carrying the measured delay in milliseconds
05:25:56.192		- Verify that the delay measurement error does not exceed the Device Profile's tolerance
05:25:56.192	--A->	Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01
05:25:56.192	--T->	fir: 1 fin: 1 seq: 0
05:25:56.192	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:25:56.192	--P->	05 64 08 C4 00 04 01 00 9A 19
05:25:56.192		C0 C1 17 8C 0C
05:25:56.192	<-P--	05 64 10 44 01 00 00 04 CD 4C
05:25:56.192		C1 C1 81 90 00 34 02 07 01 00 00 27 EB
05:25:56.192	<-L--	master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 16 dest: 1 src: 1024
05:25:56.192	<-T--	fir: 1 fin: 1 seq: 1
05:25:56.192	<-A--	Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x01 IIN(DeviceRestart, NeedTime)
05:25:56.192		g52v2, 1-Byte Count, count: 1
05:25:56.192		delay: 0
05:25:56.193	[PLG]	Delay measurement is within acceptable range (+/- 0)
05:25:56.193	--A->	Delay Meas(0x17) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02
05:25:56.193	--T->	fir: 1 fin: 1 seq: 0
05:25:56.193	--L->	master: 1 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0xC4 length: 8 dest: 1024 src: 1
05:25:56.193	--P->	05 64 08 C4 00 04 01 00 9A 19
05:25:56.193		C0 C2 17 27 BC
05:25:56.193	<-P--	05 64 10 44 01 00 00 04 CD 4C
05:25:56.193		C2 C2 81 90 00 34 02 07 01 00 00 6A D8
05:25:56.193	<-L--	master: 0 pri: 1 fcb: 0 fcv: 0 func: UNCONFIRMED_USER_DATA(0x04) 0x44 length: 16 dest: 1 src: 1024
05:25:56.193	<-T--	fir: 1 fin: 1 seq: 2
05:25:56.193	<-A--	Response(0x81) fir: 1 fin: 1 con: 0 uns: 0 seq: 0x02 IIN(DeviceRestart, NeedTime)
05:25:56.193		g52v2, 1-Byte Count, count: 1
05:25:56.193		delay: 0
05:25:56.193	[PLG]	Delay measurement is within acceptable range (+/- 0)
05:25:56.193		Passed procedure: 8.7.1.2