STH Recent Preflight: 60827
Executing preflight for 60827 at Sat May 31 16:42:20 SAST 2025.
Log can be found in /atlas/obs/03/60827/preflight.dat.
Setting donefile '/atlas/obs/03/60827/preflight_complete.20250531144220.21120' on successful script completion.
Sitech host is tcs.
Disabling voice.exe countdown.
Disabling chiller checks.
Disabling dehumidifier power check.
Logging errors to /tmp/preflight.20250531144220.21120.
Sat May 31 16:42:20 SAST 2025 [elapsed=0 sec] DFM (initialization)
get service string...OK
service is running...OK
is initialized...OK
Sat May 31 16:42:20 SAST 2025 [elapsed=0 sec] Getting TCS lock.
OK TCS lock granted to preflight-STH [757fef1f-1bdf-4a96-80fb-cb2ad9c4114b;1800]
Sat May 31 16:42:20 SAST 2025 [elapsed=0 sec] Enabling red LEDs for preflight.
doorpsw 3 ON redLED
Sat May 31 16:42:21 SAST 2025 [elapsed=1 sec] About to start STH preflight. Point your web browser at http://localhost:7354.
Sat May 31 16:42:21 SAST 2025 [elapsed=1 sec] auxcam is disabled.
Sat May 31 16:42:21 SAST 2025 [elapsed=1 sec] Skipping auxcam.
error: unknown module: vent
Sat May 31 16:42:21 SAST 2025 [elapsed=1 sec] DEADMAN
Get heartbeat host ... got 'tcs'
Fetching timestamp (redis-cli -h tcs) ... done. Got response: 1748702534
OK
Sat May 31 16:42:21 SAST 2025 [elapsed=1 sec] OPSEC
AUTO mode: ...OK
Sat May 31 16:42:21 SAST 2025 [elapsed=1 sec] CLUSTER NFS MOUNTS
admin proc1:/export/atlas-cal...OK
admin proc1:/export/atlas-red...OK
proc1 admin:/export/atlas-obs...OK
proc2 admin:/export/atlas-obs...OK
proc2 proc1:/export/atlas-cal...OK
proc2 proc1:/export/atlas-red...OK
proc3 admin:/export/atlas-obs...OK
proc3 proc1:/export/atlas-cal...OK
proc3 proc1:/export/atlas-red...OK
proc4 admin:/export/atlas-obs...OK
proc4 proc1:/export/atlas-cal...OK
proc4 proc1:/export/atlas-red...OK
Sat May 31 16:42:23 SAST 2025 [elapsed=3 sec] SCREENS
admin dash-tcsdata...OK
admin dash-recent...OK
admin dash-skycoverage...OK
admin dash-logstamp...OK
proc1 redq...OK
proc1 prochain-redpost-03a...OK
proc1 prochain-redpost-03x...OK
Sat May 31 16:42:23 SAST 2025 [elapsed=3 sec] QUEUE
0 observations queued.
Sat May 31 16:42:24 SAST 2025 [elapsed=4 sec] CLOCKS
admin: Sat May 31 14:42:24 UTC 2025
met: OK
proc1: OK
proc2: OK
proc3: OK
proc4: OK
archon: OK
NTP:
remote refid st t when poll reach delay offset jitter
==============================================================================
+192.168.4.5 .GPS. 1 u 1046 1024 301 1.066 0.108 0.445
*metbox2.sth.atl .PPS. 1 u 425 1024 377 0.319 0.096 0.089
ntp.ubuntu.com .POOL. 16 p - 64 0 0.000 0.000 0.000
-zibbi.ngei.csir 155.232.19.7 2 u 207 1024 377 23.953 0.357 2.058
+ntp.as3741.net 155.232.19.6 2 u 921 1024 377 22.459 0.225 1.069
-ntp2.as3741.net 155.232.19.6 2 u 1139 1024 376 7.261 -0.061 0.610
-ntp2.inx.net.za 183.3.52.101 2 u 460 1024 377 7.664 0.224 0.838
-102.222.100.153 155.232.19.6 2 u 811 1024 377 7.622 2.551 2.990
#za-jnb-rs01b.dp 210.182.58.253 2 u 252 1024 377 24.582 3.422 2.389
+tick.sanren.ac. .TC. 1 u 516 1024 377 24.070 0.158 0.780
-ntp.urbanwave.c 196.21.187.2 2 u 155 1024 377 23.030 0.561 0.801
-ntp4.inx.net.za 183.3.52.101 2 u 915 1024 377 23.423 -0.308 0.046
Sat May 31 16:42:28 SAST 2025 [elapsed=8 sec] DISKS
200GB available in /atlas/obs...OK (5089GB)
200GB available in /atlas/red...OK (9148GB)
Checking disks on admin ... archon ... tcs ... proc1 ... proc2 ... proc3 ... proc4 ... done
Filesystem Size Used Avail Use% Mounted_on
admin:/dev/md0p2 11T 5.4T 4.9T 53% /
admin:/dev/loop1 105M 105M 0 100% /snap/core/17200
admin:/dev/loop2 105M 105M 0 100% /snap/core/17210
archon:/dev/sda2 117G 21G 91G 19% /
archon:/dev/loop0 105M 105M 0 100% /snap/core/17200
archon:/dev/sda1 511M 6.6M 505M 2% /boot/efi
archon:/dev/loop2 105M 105M 0 100% /snap/core/17210
tcs:/dev/mapper/ubuntu--vg-ubuntu--lv 98G 33G 61G 35% /
tcs:/dev/nvme0n1p2 2.0G 131M 1.7G 8% /boot
tcs:/dev/nvme0n1p1 1.1G 6.1M 1.1G 1% /boot/efi
proc1:/dev/md0p1 15T 4.7T 8.8T 35% /
proc1:/dev/loop1 105M 105M 0 100% /snap/core/17200
proc1:/dev/loop2 105M 105M 0 100% /snap/core/17210
proc2:/dev/md0p1 15T 377G 13T 3% /
proc2:/dev/loop0 105M 105M 0 100% /snap/core/17200
proc2:/dev/loop2 105M 105M 0 100% /snap/core/17210
proc3:/dev/md0p1 15T 728G 13T 6% /
proc3:/dev/loop1 105M 105M 0 100% /snap/core/17200
proc3:/dev/loop2 105M 105M 0 100% /snap/core/17210
proc4:/dev/md0p1 15T 1.1T 13T 8% /
proc4:/dev/loop1 105M 105M 0 100% /snap/core/17200
proc4:/dev/loop2 105M 105M 0 100% /snap/core/17210
Sat May 31 16:42:28 SAST 2025 [elapsed=8 sec] SERVICES1
qcam
chiller...OK
dome...OK
mount...OK
modo...OK
cam...OK
acam...OK
weather...OK
met...OK
sentry...OK
dfm...OK
duplicates...OK
Sat May 31 16:42:28 SAST 2025 [elapsed=8 sec] Disabling mount tracking.
Sat May 31 16:42:28 SAST 2025 [elapsed=8 sec] SERVICES2
Sat May 31 16:42:28 SAST 2025 [elapsed=8 sec] CHILLER
status...OK
chiller: 3.0/3.0C ? chiller=ON dryer=? IDLE
Sat May 31 16:42:32 SAST 2025 [elapsed=12 sec] DOME
status...OK
audio setup: using amcam-mezz-s to record
Pointing webcam to azcheck position ... done
Homing the dome ... waiting ... done
Attempting audio conversion ... size= 918kB time=00:00:29.37 bitrate= 256.0kbits/s speed=1.49e+03x
audio converted to domehome.wav.
Copy dome audio to dashboards ... done
slewing to azimuth 0 (N)...OK
Copy azcheck JPEG to dashboards ... done
parking...OK
dome: AZ=89.99 CLOSED/CLOSED (0%) IDLE
Sat May 31 16:45:13 SAST 2025 [elapsed=173 sec] MOUNT
blinky status...OK
motor logs...OK
slewing to az=70,alt=70...OK
slewing to az=290,alt=70...OK
parking...OK
mount: 129.38 -29.49, az/alt=324.67 +86.49 idle(e) IDLE
Sat May 31 16:46:11 SAST 2025 [elapsed=231 sec] MODO
status...OK
slewing to az=60,alt=60...OK
modo: dome=stopped mount=tracking IDLE
Sat May 31 16:46:32 SAST 2025 [elapsed=252 sec] CAM SERVICE
status...OK
cam: main=[idle] aux=[off] N=0/0 spi=38.4 IDLE
Sat May 31 16:46:32 SAST 2025 [elapsed=252 sec] ACAM
status Camera tripped exists... OK
Camera tripped is current... OK (9 seconds old)
Software failsafe ready... OK (NA)
CCD on...OK
ION pump on...OK
CCD temp...OK (-55.0C)
Checking CCD plane: Z0=+1705.00 DZDX=-882.00 DZDY=+2278.00
acam: -55C CCD TEC ION e=30.0s d=0.6s N=0 IDLE
Sat May 31 16:46:32 SAST 2025 [elapsed=252 sec] WEATHER
status weather: clear 13.7C 20% 20/28kph@336 DP23.6C/46C/d IDLE
...OK
Sat May 31 16:46:33 SAST 2025 [elapsed=253 sec] MET
status...OK
met: c=N o=Y Ro1d Co1d Wo1d Ho19h To73d Do15h IDLE
Sat May 31 16:46:33 SAST 2025 [elapsed=253 sec] SENTRY
status...OK
sentry: close=YES open=NO drop=NO IDLE
Sat May 31 16:46:34 SAST 2025 [elapsed=254 sec] DFM (SHUTTERS)
initializing and homing shutters...
mount 158.30 -14.63, az/alt=59.90 +60.06 tracking(w) IDLE 0s
A 0 0.0mm 15 N F R | B 0 0.0mm 15 N F R
initialized motor A constants
initialized motor B constants
A 0 0.0mm 15 N F R | B 0 0.0mm 15 N F R
A 0.020s 3 0.0%
B 0.020s -2 0.0%
A 2 0.1mm 15 N F R | B -2 -0.1mm 15 N F R
finding forward (close) limit for shutter A
...done
backing off limit
........................backing off 4 sec...
at limit
done
finding forward (close) limit for shutter B
...done
backing off limit
..............backing off 4 sec...
at limit
done
A 0 0.0mm 15 N F R | B 0 0.0mm 15 N F R
exercising shutters...Using amcam-mezz-s to record
A 0.020s 6 0.1%
A 0.051s 102 1.1%
A 0.081s 383 4.2%
A 0.111s 721 7.9%
A 0.142s 1173 12.8%
A 0.172s 1762 19.2%
A 0.202s 2465 26.9%
A 0.233s 3260 35.6%
A 0.263s 4163 45.5%
A 0.293s 5114 55.9%
A 0.324s 5992 65.5%
A 0.354s 6779 74.1%
A 0.384s 7438 81.3%
A 0.414s 8000 87.4%
A 0.445s 8466 92.5%
A 0.475s 8791 96.0%
A 0.505s 9022 98.6%
A 0.535s 9151 100.0%
B 0.020s 1 0.0%
B 0.051s 90 1.0%
B 0.081s 374 4.1%
B 0.111s 712 7.8%
B 0.142s 1181 12.9%
B 0.172s 1758 19.2%
B 0.202s 2465 26.9%
B 0.233s 3232 35.3%
B 0.263s 4169 45.5%
B 0.293s 5102 55.7%
B 0.323s 5964 65.2%
B 0.354s 6751 73.7%
B 0.384s 7415 81.0%
B 0.414s 7992 87.3%
B 0.444s 8443 92.2%
B 0.475s 8799 96.1%
B 0.505s 9028 98.6%
B 0.535s 9143 99.9%
B 0.566s 9161 100.0%
sleeping 3 sec between shutter moves...
A 0.020s 9150 100.0%
A 0.050s 9063 99.0%
A 0.081s 8772 95.8%
A 0.111s 8414 91.9%
A 0.141s 7969 87.1%
A 0.172s 7372 80.5%
A 0.202s 6691 73.1%
A 0.232s 5896 64.4%
A 0.263s 4982 54.4%
A 0.293s 4045 44.2%
A 0.323s 3166 34.6%
A 0.353s 2377 26.0%
A 0.384s 1710 18.7%
A 0.414s 1146 12.5%
A 0.444s 697 7.6%
A 0.475s 356 3.9%
A 0.505s 128 1.4%
A 0.535s 13 0.1%
A 0.565s -6 0.0%
B 0.020s 9145 99.9%
B 0.050s 9028 98.6%
B 0.081s 8762 95.7%
B 0.111s 8411 91.9%
B 0.141s 7942 86.8%
B 0.172s 7359 80.4%
B 0.202s 6670 72.9%
B 0.232s 5870 64.1%
B 0.263s 4953 54.1%
B 0.293s 4020 43.9%
B 0.323s 3139 34.3%
B 0.353s 2361 25.8%
B 0.384s 1693 18.5%
B 0.414s 1125 12.3%
B 0.444s 684 7.5%
B 0.475s 347 3.8%
B 0.505s 121 1.3%
B 0.535s 10 0.1%
B 0.566s -5 0.0%
A 0 0.0mm 15 N F R | B -5 -0.2mm 15 N F R
---------------------------------------------------
Evaluating shutter behavior:
Shutter A opened to 100.0 percent in 0.535 seconds.
Shutter B opened to 100.0 percent in 0.566 seconds.
Shutter A closed to 0.0 percent in 0.565 seconds.
Shutter B closed to 0.0 percent in 0.566 seconds.
Problems: 0
---------------------------------------------------
Attempting audio conversion ... size= 226kB time=00:00:07.23 bitrate= 256.1kbits/s speed=1.12e+03x
audio converted to shutter.wav.
Copying shutter audio to dashboards ... done
DFM (FOCUS)
changing to best focus... dfm: filter=o[2] foc=9230 IDLE
Sat May 31 16:47:12 SAST 2025 [elapsed=292 sec] IMAGING (acam+auxcam)
status...OK
cam: main=[idle] aux=[off] N=0/0 spi=38.4 IDLE
taking preflight exposures:
acam...OK
acam image:
122M May 31 16:47 /atlas/obs/03a/60827/03a60827e0001o.arch.fz
AUXCAM: Skipping (noauxcam=1).
Sat May 31 16:47:35 SAST 2025 [elapsed=315 sec] DEHUMIDIFIER
OTA humidity exists...OK
OTA humidity is current... OK (39 seconds old)
OTA humidity level...OK (6%)
Dome humidity exists...OK
Dome humidity is current... OK
Sat May 31 16:47:35 SAST 2025 [elapsed=315 sec] SCHEDULE
Status...OK
Checking scheduled filter...correct filter inserted
dfm: OK [bestfocus]
60826.61638297|info|galildriver|using focus model: foc=9187+(4.30)*15.4+(-0.40)*60.2=9229.1
60826.61638787|info|galildriver|o 2 IN | cass: 3050910 15.25 mm b=23 move=NO | arm: 409734 477.00 mm b=23 move=OK | foc: 54005624 9231 um b=2f [cmd]
bestfocus for o...OK
Sat May 31 16:47:36 SAST 2025 [elapsed=316 sec] Parking the mount.
Parking ... mount: task <-parksouth> accepted
Waiting ... Mount is parked.
Sat May 31 16:48:06 SAST 2025 [elapsed=346 sec] Disabling mount tracking.
Waiting on the mount ... done.
Turning tracking off ... done.
Waiting on the mount ... done.
Recheck mount status ... done.
doorpsw 3 OFF redLED
doorpsw 2 OFF whiteLED
Sat May 31 16:48:07 SAST 2025 [elapsed=347 sec] NOTICES: det_dzdx=-882 is outside range +-250 from -558; det_dzdy=2278 is outside range +-250 from -1915;
Preflight completed successfully. See
http://tinyurl.com/sthpreflight
--
Please reduce summit bandwidth by turning off your webcam viewer.
Sat May 31 16:48:07 SAST 2025 [elapsed=347 sec] Happy observing!
Sat May 31 16:48:07 SAST 2025 [elapsed=347 sec] Preflight took 347 seconds to complete.
Sat May 31 16:48:07 SAST 2025 [elapsed=347 sec] STARTING CLEANUP
Turning off LEDs
doorpsw 3 OFF redLED
doorpsw 2 OFF whiteLED
Releasing TCS lock [preflight]
OK TCS lock released by preflight-STH
Preflight image
Shutter acutation data:
A 0.020s 4 0.0% A 0.050s 117 1.3% A 0.081s 385 4.3% A 0.111s 730 8.1% A 0.141s 1198 13.3% A 0.171s 1782 19.8% A 0.201s 2465 27.4% A 0.232s 3264 36.3% A 0.262s 4174 46.4% A 0.292s 5106 56.7% A 0.322s 5981 66.5% A 0.353s 6748 75.0% A 0.383s 7379 82.0% A 0.413s 7919 88.0% A 0.443s 8350 92.8% A 0.473s 8663 96.3% A 0.504s 8886 98.7% A 0.534s 8995 99.9% B 0.020s 1 0.0% B 0.051s 121 1.3% B 0.081s 391 4.3% B 0.111s 730 8.1% B 0.141s 1222 13.6% B 0.172s 1795 19.9% B 0.202s 2491 27.7% B 0.232s 3296 36.6% B 0.262s 4198 46.6% B 0.293s 5104 56.7% B 0.323s 6006 66.7% B 0.353s 6741 74.9% B 0.383s 7408 82.3% B 0.414s 7928 88.1% B 0.444s 8374 93.0% B 0.474s 8688 96.5% B 0.504s 8890 98.8% B 0.535s 8993 99.9% sleeping 3 sec between shutter moves... A 0.020s 8998 100.0% A 0.051s 8900 98.9% A 0.081s 8631 95.9% A 0.111s 8273 91.9% A 0.141s 7826 87.0% A 0.172s 7244 80.5% A 0.202s 6561 72.9% A 0.232s 5771 64.1% A 0.262s 4853 53.9% A 0.292s 3918 43.5% A 0.323s 3049 33.9% A 0.353s 2281 25.3% A 0.383s 1633 18.1% A 0.414s 1080 12.0% A 0.444s 646 7.2% A 0.474s 331 3.7% A 0.504s 111 1.2% A 0.535s 7 0.1% B 0.020s 8989 99.9% B 0.050s 8861 98.5% B 0.081s 8607 95.6% B 0.111s 8256 91.7% B 0.141s 7782 86.5% B 0.171s 7225 80.3% B 0.202s 6516 72.4% B 0.232s 5738 63.8% B 0.262s 4829 53.7% B 0.292s 3898 43.3% B 0.322s 3022 33.6% B 0.353s 2267 25.2% B 0.383s 1605 17.8% B 0.413s 1067 11.9% B 0.443s 642 7.1% B 0.474s 321 3.6% B 0.504s 112 1.2% B 0.534s 6 0.1% A 1 0.0mm 15 N F R | B -1 -0.0mm 15 N F R