2023-08-06_16:32:30.581255Z OMC_LOCK REQUEST: READY_W_NO_WHITENING
2023-08-06_16:32:30.581416Z OMC_LOCK STALL cleared
2023-08-06_16:32:30.581518Z OMC_LOCK calculating path: DOWN->READY_W_NO_WHITENING
2023-08-06_16:32:30.581994Z OMC_LOCK new target: WAIT_FOR_AS_LIGHT
2023-08-06_16:32:30.583067Z OMC_LOCK executing state: DOWN (110)
2023-08-06_16:32:30.583555Z OMC_LOCK [DOWN.enter]
2023-08-06_16:32:30.585371Z OMC_LOCK [DOWN.main] ezca: H1:OMC-ASC_MASTERGAIN => 0
2023-08-06_16:32:30.837576Z OMC_LOCK [DOWN.main] ezca: H1:OMC-LSC_SERVO => ONLY ON: INPUT, LIMIT, OUTPUT, DECIMATION, FM6, FM8, FM10
2023-08-06_16:32:31.089206Z OMC_LOCK [DOWN.main] ezca: H1:OMC-DCPD_NORM_FILT => ON: INPUT
2023-08-06_16:32:31.252587Z OMC_LOCK EDGE: DOWN->WAIT_FOR_AS_LIGHT
2023-08-06_16:32:31.253418Z OMC_LOCK calculating path: WAIT_FOR_AS_LIGHT->READY_W_NO_WHITENING
2023-08-06_16:32:31.261043Z OMC_LOCK new target: ASC_QPD_ON
2023-08-06_16:32:31.267929Z OMC_LOCK executing state: WAIT_FOR_AS_LIGHT (5)
2023-08-06_16:32:31.270825Z OMC_LOCK [WAIT_FOR_AS_LIGHT.main] timer['wait'] done
2023-08-06_16:32:31.271429Z OMC_LOCK [WAIT_FOR_AS_LIGHT.main] timer['wait'] = 0
2023-08-06_16:32:32.434062Z 0.21973760696974667
2023-08-06_16:32:32.434062Z 0.23121555555950513
2023-08-06_16:32:32.503877Z OMC_LOCK EDGE: WAIT_FOR_AS_LIGHT->ASC_QPD_ON
2023-08-06_16:32:32.503877Z OMC_LOCK calculating path: ASC_QPD_ON->READY_W_NO_WHITENING
2023-08-06_16:32:32.503877Z OMC_LOCK new target: SET_WHITENING
2023-08-06_16:32:32.503877Z OMC_LOCK executing state: ASC_QPD_ON (120)
2023-08-06_16:32:32.515952Z OMC_LOCK [ASC_QPD_ON.enter]
2023-08-06_16:32:33.619723Z OMC_LOCK [ASC_QPD_ON.main] ezca: H1:OMC-ASC_MASTERGAIN => 0.02
2023-08-06_16:32:33.871508Z OMC_LOCK [ASC_QPD_ON.main] ezca: H1:OMC-ASC_POS_X => ON: FM2
2023-08-06_16:32:34.123308Z OMC_LOCK [ASC_QPD_ON.main] ezca: H1:OMC-ASC_POS_Y => ON: FM2
2023-08-06_16:32:34.375261Z OMC_LOCK [ASC_QPD_ON.main] ezca: H1:OMC-ASC_ANG_X => ON: FM2
2023-08-06_16:32:34.629467Z OMC_LOCK [ASC_QPD_ON.main] ezca: H1:OMC-ASC_ANG_Y => ON: FM2
2023-08-06_16:32:34.829078Z OMC_LOCK EDGE: ASC_QPD_ON->SET_WHITENING
2023-08-06_16:32:34.829850Z OMC_LOCK calculating path: SET_WHITENING->READY_W_NO_WHITENING
2023-08-06_16:32:34.829850Z OMC_LOCK new target: PREP_OMC_SCAN
2023-08-06_16:32:34.830959Z OMC_LOCK executing state: SET_WHITENING (130)
2023-08-06_16:32:34.832830Z OMC_LOCK [SET_WHITENING.main] USERMSG 0: Whitening is already OFF!
2023-08-06_16:32:34.893736Z OMC_LOCK [SET_WHITENING.run] USERMSG 0: It did not make sense to remove whitening, so did nothing.
2023-08-06_16:32:35.020259Z OMC_LOCK EDGE: SET_WHITENING->PREP_OMC_SCAN
2023-08-06_16:32:35.020259Z OMC_LOCK calculating path: PREP_OMC_SCAN->READY_W_NO_WHITENING
2023-08-06_16:32:35.020639Z OMC_LOCK new target: FIND_CARRIER
2023-08-06_16:32:35.021528Z OMC_LOCK executing state: PREP_OMC_SCAN (140)
2023-08-06_16:32:36.130225Z OMC_LOCK [PREP_OMC_SCAN.main] ezca: H1:OMC-PZT2_TRAMP => 0
2023-08-06_16:32:36.135008Z OMC_LOCK [PREP_OMC_SCAN.main] timer['sleep'] done
2023-08-06_16:32:36.135008Z OMC_LOCK [PREP_OMC_SCAN.main] timer['sleep'] = 0
2023-08-06_16:32:36.388272Z OMC_LOCK [PREP_OMC_SCAN.main] ezca: H1:LSC-OMC_DC => ONLY ON: INPUT, OFFSET, OUTPUT, DECIMATION
2023-08-06_16:32:37.578564Z OMC_LOCK EDGE: PREP_OMC_SCAN->FIND_CARRIER
2023-08-06_16:32:37.579269Z OMC_LOCK calculating path: FIND_CARRIER->READY_W_NO_WHITENING
2023-08-06_16:32:37.579269Z OMC_LOCK new target: OMC_LSC_ON
2023-08-06_16:32:37.580694Z OMC_LOCK executing state: FIND_CARRIER (150)
2023-08-06_16:32:37.583659Z OMC_LOCK [FIND_CARRIER.enter]
2023-08-06_16:32:38.688056Z OMC_LOCK [FIND_CARRIER.main] ezca: H1:OMC-PZT2_TRAMP => 60
2023-08-06_16:32:38.688768Z OMC_LOCK [FIND_CARRIER.main] Scan starting at 1375374776
2023-08-06_16:32:38.689240Z OMC_LOCK [FIND_CARRIER.main] ezca: H1:OMC-PZT2_OFFSET => 30
2023-08-06_16:32:38.689240Z OMC_LOCK [FIND_CARRIER.main] Sweeping OMC to find carrier and 45MHz sidebands...