root@ElNido:/home/pi# journalctl -f -u satnogs-client.service -- Logs begin at Thu 2019-08-08 19:17:01 -03. -- Aug 08 20:31:07 ElNido satnogs-client[560]: 2019-08-08 20:31:07,949 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:32:07 UTC)" (scheduled at 2019-08-08 23:31:07.924407+00:00) Aug 08 20:31:07 ElNido satnogs-client[560]: 2019-08-08 20:31:07,996 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:33:07 UTC)" (scheduled at 2019-08-08 23:31:07.940218+00:00) Aug 08 20:31:08 ElNido satnogs-client[560]: 2019-08-08 20:31:08,004 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:33:07 UTC)" executed successfully Aug 08 20:31:14 ElNido satnogs-client[560]: 2019-08-08 20:31:14,325 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:32:07 UTC)" executed successfully Aug 08 20:32:07 ElNido satnogs-client[560]: 2019-08-08 20:32:07,944 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:33:07 UTC)" (scheduled at 2019-08-08 23:32:07.924407+00:00) Aug 08 20:32:14 ElNido satnogs-client[560]: 2019-08-08 20:32:14,309 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:33:07 UTC)" executed successfully Aug 08 20:33:07 ElNido satnogs-client[560]: 2019-08-08 20:33:07,949 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:34:07 UTC)" (scheduled at 2019-08-08 23:33:07.924407+00:00) Aug 08 20:33:07 ElNido satnogs-client[560]: 2019-08-08 20:33:07,996 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:35:07 UTC)" (scheduled at 2019-08-08 23:33:07.940218+00:00) Aug 08 20:33:08 ElNido satnogs-client[560]: 2019-08-08 20:33:08,004 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:35:07 UTC)" executed successfully Aug 08 20:33:14 ElNido satnogs-client[560]: 2019-08-08 20:33:14,283 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:34:07 UTC)" executed successfully Aug 08 20:34:07 ElNido satnogs-client[560]: 2019-08-08 20:34:07,949 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:35:07 UTC)" (scheduled at 2019-08-08 23:34:07.924407+00:00) Aug 08 20:34:09 ElNido satnogs-client[560]: 2019-08-08 20:34:09,289 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:35:07 UTC)" executed successfully Aug 08 20:34:50 ElNido satnogs-client[560]: 2019-08-08 20:34:50,022 - apscheduler.executors.default - INFO - Running job "spawn_observer (trigger: date[2019-08-08 23:34:50 UTC], next run at: 2019-08-08 23:34:50 UTC)" (scheduled at 2019-08-08 23:34:50+00:00) Aug 08 20:34:50 ElNido satnogs-client[560]: 2019-08-08 20:34:50,086 - satnogsclient - ERROR - Cannot connect to socket 127.0.0.1:4533 Aug 08 20:34:50 ElNido satnogs-client[560]: 2019-08-08 20:34:50,126 - satnogsclient - ERROR - Cannot connect to socket 127.0.0.1:4533 Aug 08 20:34:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:34:50 ElNido satnogs-client[560]: Exception in thread Thread-2: Aug 08 20:34:50 ElNido satnogs-client[560]: Traceback (most recent call last): Aug 08 20:34:50 ElNido satnogs-client[560]: File "/usr/lib/python2.7/threading.py", line 801, in __bootstrap_inner Aug 08 20:34:50 ElNido satnogs-client[560]: self.run() Aug 08 20:34:50 ElNido satnogs-client[560]: File "/usr/lib/python2.7/threading.py", line 754, in run Aug 08 20:34:50 ElNido satnogs-client[560]: self.__target(*self.__args, **self.__kwargs) Aug 08 20:34:50 ElNido satnogs-client[560]: File "/var/lib/satnogs/local/lib/python2.7/site-packages/satnogsclient/observer/worker.py", line 134, in _communicate_tracking_info Aug 08 20:34:50 ElNido satnogs-client[560]: self.send_to_socket(p, sock) Aug 08 20:34:50 ElNido satnogs-client[560]: File "/var/lib/satnogs/local/lib/python2.7/site-packages/satnogsclient/observer/worker.py", line 180, in send_to_socket Aug 08 20:34:50 ElNido satnogs-client[560]: position = sock.send("p\n").split('\n') Aug 08 20:34:50 ElNido satnogs-client[560]: File "/var/lib/satnogs/local/lib/python2.7/site-packages/satnogsclient/observer/commsocket.py", line 76, in send Aug 08 20:34:50 ElNido satnogs-client[560]: self.s.send(message) Aug 08 20:34:50 ElNido satnogs-client[560]: error: [Errno 32] Broken pipe Aug 08 20:34:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:34:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:34:54 ElNido satnogs-client[560]: gr-osmosdr 0.1.4 (0.1.4) gnuradio 3.7.10 Aug 08 20:34:54 ElNido satnogs-client[560]: built-in source types: file osmosdr fcd rtl rtl_tcp uhd miri hackrf bladerf rfspace airspy soapy redpitaya Aug 08 20:34:54 ElNido satnogs-client[560]: Using device #0 Realtek RTL2838UHIDIR SN: 00000001 Aug 08 20:34:54 ElNido satnogs-client[560]: Using 32 buffers of size 16384. Aug 08 20:34:54 ElNido satnogs-client[560]: Found Rafael Micro R820T tuner Aug 08 20:34:54 ElNido satnogs-client[560]: [R82XX] PLL not locked! Aug 08 20:34:54 ElNido satnogs-client[560]: Exact sample rate is: 1000000.026491 Hz Aug 08 20:34:54 ElNido satnogs-client[560]: [R82XX] PLL not locked! Aug 08 20:35:07 ElNido satnogs-client[560]: 2019-08-08 20:35:07,983 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:35:07 UTC)" (scheduled at 2019-08-08 23:35:07.924407+00:00) Aug 08 20:35:08 ElNido satnogs-client[560]: 2019-08-08 20:35:08,009 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:37:07 UTC)" (scheduled at 2019-08-08 23:35:07.940218+00:00) Aug 08 20:35:08 ElNido satnogs-client[560]: 2019-08-08 20:35:08,015 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:37:07 UTC)" executed successfully Aug 08 20:35:09 ElNido satnogs-client[560]: 2019-08-08 20:35:09,309 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:36:07 UTC)" executed successfully Aug 08 20:36:07 ElNido satnogs-client[560]: 2019-08-08 20:36:07,979 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:37:07 UTC)" (scheduled at 2019-08-08 23:36:07.924407+00:00) Aug 08 20:36:09 ElNido satnogs-client[560]: 2019-08-08 20:36:09,284 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:37:07 UTC)" executed successfully Aug 08 20:37:07 ElNido satnogs-client[560]: 2019-08-08 20:37:07,965 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:37:07 UTC)" (scheduled at 2019-08-08 23:37:07.924407+00:00) Aug 08 20:37:07 ElNido satnogs-client[560]: 2019-08-08 20:37:07,977 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:37:07 UTC)" (scheduled at 2019-08-08 23:37:07.940218+00:00) Aug 08 20:37:07 ElNido satnogs-client[560]: 2019-08-08 20:37:07,990 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:39:07 UTC)" executed successfully Aug 08 20:37:14 ElNido satnogs-client[560]: 2019-08-08 20:37:14,391 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:38:07 UTC)" executed successfully Aug 08 20:38:07 ElNido satnogs-client[560]: 2019-08-08 20:38:07,974 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:39:07 UTC)" (scheduled at 2019-08-08 23:38:07.924407+00:00) Aug 08 20:38:14 ElNido satnogs-client[560]: 2019-08-08 20:38:14,276 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:39:07 UTC)" executed successfully Aug 08 20:39:07 ElNido satnogs-client[560]: 2019-08-08 20:39:07,956 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:40:07 UTC)" (scheduled at 2019-08-08 23:39:07.924407+00:00) Aug 08 20:39:07 ElNido satnogs-client[560]: 2019-08-08 20:39:07,969 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:41:07 UTC)" (scheduled at 2019-08-08 23:39:07.940218+00:00) Aug 08 20:39:07 ElNido satnogs-client[560]: 2019-08-08 20:39:07,975 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:41:07 UTC)" executed successfully Aug 08 20:39:09 ElNido satnogs-client[560]: 2019-08-08 20:39:09,205 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:40:07 UTC)" executed successfully Aug 08 20:40:07 ElNido satnogs-client[560]: 2019-08-08 20:40:07,973 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:41:07 UTC)" (scheduled at 2019-08-08 23:40:07.924407+00:00) Aug 08 20:40:14 ElNido satnogs-client[560]: 2019-08-08 20:40:14,452 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:41:07 UTC)" executed successfully Aug 08 20:41:07 ElNido satnogs-client[560]: 2019-08-08 20:41:07,954 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:42:07 UTC)" (scheduled at 2019-08-08 23:41:07.924407+00:00) Aug 08 20:41:07 ElNido satnogs-client[560]: 2019-08-08 20:41:07,960 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:41:07 UTC)" (scheduled at 2019-08-08 23:41:07.940218+00:00) Aug 08 20:41:07 ElNido satnogs-client[560]: 2019-08-08 20:41:07,975 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:43:07 UTC)" executed successfully Aug 08 20:41:09 ElNido satnogs-client[560]: 2019-08-08 20:41:09,172 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:42:07 UTC)" executed successfully Aug 08 20:42:07 ElNido satnogs-client[560]: 2019-08-08 20:42:07,977 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:43:07 UTC)" (scheduled at 2019-08-08 23:42:07.924407+00:00) Aug 08 20:42:09 ElNido satnogs-client[560]: 2019-08-08 20:42:09,187 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:43:07 UTC)" executed successfully Aug 08 20:43:07 ElNido satnogs-client[560]: 2019-08-08 20:43:07,968 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:44:07 UTC)" (scheduled at 2019-08-08 23:43:07.924407+00:00) Aug 08 20:43:07 ElNido satnogs-client[560]: 2019-08-08 20:43:07,978 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:45:07 UTC)" (scheduled at 2019-08-08 23:43:07.940218+00:00) Aug 08 20:43:07 ElNido satnogs-client[560]: 2019-08-08 20:43:07,984 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:45:07 UTC)" executed successfully Aug 08 20:43:09 ElNido satnogs-client[560]: 2019-08-08 20:43:09,188 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:44:07 UTC)" executed successfully Aug 08 20:43:33 ElNido satnogs-client[560]: 2019-08-08 20:43:33,163 - satnogsclient - INFO - Closing socket: Aug 08 20:43:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:43:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:43:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:43:50 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:44:07 ElNido satnogs-client[560]: 2019-08-08 20:44:07,988 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:45:07 UTC)" (scheduled at 20 19-08-08 23:44:07.924407+00:00) Aug 08 20:44:14 ElNido satnogs-client[560]: 2019-08-08 20:44:14,376 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:45:07 UTC)" executed successfully Aug 08 20:44:20 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:44:20 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:44:20 ElNido satnogs-client[560]: postob script executed succesfully Aug 08 20:44:20 ElNido satnogs-client[560]: linux; GNU C++ version 6.2.0 20161010; Boost_106100; UHD_003.009.005-0-unknown Aug 08 20:44:37 ElNido satnogs-client[560]: 2019-08-08 20:44:37,208 - apscheduler.executors.default - INFO - Job "spawn_observer (trigger: date[2019-08-08 23:34:50 UTC], next run at: 2019-08-08 23:34:50 UTC)" executed successfully Aug 08 20:45:07 ElNido satnogs-client[560]: 2019-08-08 20:45:07,981 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:46:07 UTC)" (scheduled at 2019-08-08 23:45:07.924407+00:00) Aug 08 20:45:08 ElNido satnogs-client[560]: 2019-08-08 20:45:08,004 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:47:07 UTC)" (scheduled at 2019-08-08 23:45:07.940218+00:00) Aug 08 20:45:14 ElNido satnogs-client[560]: 2019-08-08 20:45:14,357 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:46:07 UTC)" executed successfully Aug 08 20:45:21 ElNido satnogs-client[560]: 2019-08-08 20:45:21,607 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:47:07 UTC)" executed successfully Aug 08 20:46:08 ElNido satnogs-client[560]: 2019-08-08 20:46:08,036 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:47:07 UTC)" (scheduled at 2019-08-08 23:46:07.924407+00:00) Aug 08 20:46:14 ElNido satnogs-client[560]: 2019-08-08 20:46:14,581 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:47:07 UTC)" executed successfully Aug 08 20:46:21 ElNido satnogs-client[560]: Waiting for 120 seconds before processing. Aug 08 20:46:21 ElNido satnogs-client[560]: Attempting to process: /datadrive/meteor/data_894969_2019-08-06T00-33-36.s Aug 08 20:46:21 ElNido satnogs-client[560]: Traceback (most recent call last): Aug 08 20:46:21 ElNido satnogs-client[560]: File "/datadrive/process_meteor.py", line 109, in Aug 08 20:46:21 ElNido satnogs-client[560]: run_medet(_file, MEDET_ARGS_COMPOSITE, "_vis") Aug 08 20:46:21 ElNido satnogs-client[560]: File "/datadrive/process_meteor.py", line 90, in run_medet Aug 08 20:46:21 ElNido satnogs-client[560]: ret_code = subprocess.call(_medet_command) Aug 08 20:46:21 ElNido satnogs-client[560]: File "/usr/lib/python2.7/subprocess.py", line 168, in call Aug 08 20:46:21 ElNido satnogs-client[560]: return Popen(*popenargs, **kwargs).wait() Aug 08 20:46:21 ElNido satnogs-client[560]: File "/usr/lib/python2.7/subprocess.py", line 390, in __init__ Aug 08 20:46:21 ElNido satnogs-client[560]: errread, errwrite) Aug 08 20:46:21 ElNido satnogs-client[560]: File "/usr/lib/python2.7/subprocess.py", line 1024, in _execute_child Aug 08 20:46:21 ElNido satnogs-client[560]: raise child_exception Aug 08 20:46:21 ElNido satnogs-client[560]: OSError: [Errno 2] No such file or directory Aug 08 20:47:07 ElNido satnogs-client[560]: 2019-08-08 20:47:07,981 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:48:07 UTC)" (scheduled at 2019-08-08 23:47:07.924407+00:00) Aug 08 20:47:07 ElNido satnogs-client[560]: 2019-08-08 20:47:07,998 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:49:07 UTC)" (scheduled at 2019-08-08 23:47:07.940218+00:00) Aug 08 20:47:08 ElNido satnogs-client[560]: 2019-08-08 20:47:08,028 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:49:07 UTC)" executed successfully Aug 08 20:47:14 ElNido satnogs-client[560]: 2019-08-08 20:47:14,325 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:48:07 UTC)" executed successfully Aug 08 20:48:07 ElNido satnogs-client[560]: 2019-08-08 20:48:07,995 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:48:07 UTC)" (scheduled at 2019-08-08 23:48:07.924407+00:00) Aug 08 20:48:14 ElNido satnogs-client[560]: 2019-08-08 20:48:14,355 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:49:07 UTC)" executed successfully Aug 08 20:49:07 ElNido satnogs-client[560]: 2019-08-08 20:49:07,984 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:50:07 UTC)" (scheduled at 2019-08-08 23:49:07.924407+00:00) Aug 08 20:49:08 ElNido satnogs-client[560]: 2019-08-08 20:49:08,004 - apscheduler.executors.default - INFO - Running job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:51:07 UTC)" (scheduled at 2019-08-08 23:49:07.940218+00:00) Aug 08 20:49:08 ElNido satnogs-client[560]: 2019-08-08 20:49:08,023 - apscheduler.executors.default - INFO - Job "post_data (trigger: interval[0:02:00], next run at: 2019-08-08 23:51:07 UTC)" executed successfully Aug 08 20:49:09 ElNido satnogs-client[560]: 2019-08-08 20:49:09,290 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:50:07 UTC)" executed successfully Aug 08 20:50:07 ElNido satnogs-client[560]: 2019-08-08 20:50:07,998 - apscheduler.executors.default - INFO - Running job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:51:07 UTC)" (scheduled at 2019-08-08 23:50:07.924407+00:00) Aug 08 20:50:17 ElNido satnogs-client[560]: 2019-08-08 20:50:17,114 - apscheduler.executors.default - INFO - Job "get_jobs (trigger: interval[0:01:00], next run at: 2019-08-08 23:51:07 UTC)" executed successfully