25.04.23 11:19:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:19:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:19:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:19:54 (+0200) # BEACON queued: 0 25.04.23 11:19:54 (+0200) # BEACON sent so far: 0 25.04.23 11:19:54 (+0200) # BEACON rejected: 0 25.04.23 11:19:54 (+0200) ### [JIT] ### 25.04.23 11:19:54 (+0200) # SX1301 time (PPS): 1714966779 25.04.23 11:19:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:19:54 (+0200) ### [GPS] ### 25.04.23 11:19:54 (+0200) Apr 25 09:19:54.230 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:19:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:19:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:19:54 (+0200) ##### END ##### 25.04.23 11:19:54 (+0200) 25.04.23 11:19:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:19:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:19:54 (+0200) INFO: [up] PUSH_ACK received in 2 ms 25.04.23 11:19:59 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:20:10 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:20:10 (+0200) 2023-04-25 09:20:10,843 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:20:10 (+0200) 2023-04-25 09:20:10,844 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:20:20 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:20:24 (+0200) 25.04.23 11:20:24 (+0200) ##### 2023-04-25 09:20:24 GMT ##### 25.04.23 11:20:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:20:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:20:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:20:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:20:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:20:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:20:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:20:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:20:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:20:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:20:24 (+0200) # TX errors: 0 25.04.23 11:20:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:20:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:20:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:20:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:20:24 (+0200) # BEACON queued: 0 25.04.23 11:20:24 (+0200) # BEACON sent so far: 0 25.04.23 11:20:24 (+0200) # BEACON rejected: 0 25.04.23 11:20:24 (+0200) ### [JIT] ### 25.04.23 11:20:24 (+0200) # SX1301 time (PPS): 1714966779 25.04.23 11:20:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:20:24 (+0200) ### [GPS] ### 25.04.23 11:20:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:20:24 (+0200) ##### END ##### 25.04.23 11:20:24 (+0200) 25.04.23 11:20:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:20:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:20:24 (+0200) Apr 25 09:20:24.229 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:20:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:20:24 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:20:30 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:20:37 (+0200) 25.04.23 11:20:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:20:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:535622µs) - drift=92µs 25.04.23 11:20:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:20:37 (+0200) 25.04.23 11:20:40 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:20:40 (+0200) 2023-04-25 09:20:40,846 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:20:40 (+0200) 2023-04-25 09:20:40,847 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:20:42 (+0200) 2023-04-25 09:20:42,680 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:20:42 (+0200) 2023-04-25 09:20:42,681 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:20:42 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,301 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:20:43 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,304 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:20:43 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,307 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:20:43 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,320 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:20:43 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,325 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:20:43 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,346 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:20:43 (+0200) 2023-04-25 09:20:43,334 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:20:43 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:20:43 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:20:43 (+0200) INFO:root:Diagnostics complete 25.04.23 11:20:50 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:20:54 (+0200) 25.04.23 11:20:54 (+0200) ##### 2023-04-25 09:20:54 GMT ##### 25.04.23 11:20:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:20:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:20:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:20:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:20:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:20:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:20:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:20:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:20:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:20:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:20:54 (+0200) # TX errors: 0 25.04.23 11:20:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:20:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:20:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:20:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:20:54 (+0200) # BEACON queued: 0 25.04.23 11:20:54 (+0200) # BEACON sent so far: 0 25.04.23 11:20:54 (+0200) # BEACON rejected: 0 25.04.23 11:20:54 (+0200) ### [JIT] ### 25.04.23 11:20:54 (+0200) # SX1301 time (PPS): 1774967616 25.04.23 11:20:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:20:54 (+0200) ### [GPS] ### 25.04.23 11:20:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:20:54 (+0200) ##### END ##### 25.04.23 11:20:54 (+0200) 25.04.23 11:20:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:20:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:20:54 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:20:54 (+0200) Apr 25 09:20:54.237 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:20:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:21:00 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:21:10 (+0200) 2023-04-25 09:21:10,850 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:21:10 (+0200) 2023-04-25 09:21:10,851 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:21:11 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:21:21 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:21:24 (+0200) 25.04.23 11:21:24 (+0200) ##### 2023-04-25 09:21:24 GMT ##### 25.04.23 11:21:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:21:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:21:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:21:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:21:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:21:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:21:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:21:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:21:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:21:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:21:24 (+0200) # TX errors: 0 25.04.23 11:21:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:21:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:21:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:21:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:21:24 (+0200) # BEACON queued: 0 25.04.23 11:21:24 (+0200) # BEACON sent so far: 0 25.04.23 11:21:24 (+0200) # BEACON rejected: 0 25.04.23 11:21:24 (+0200) ### [JIT] ### 25.04.23 11:21:24 (+0200) # SX1301 time (PPS): 1774967616 25.04.23 11:21:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:21:24 (+0200) ### [GPS] ### 25.04.23 11:21:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:21:24 (+0200) ##### END ##### 25.04.23 11:21:24 (+0200) 25.04.23 11:21:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:21:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:21:24 (+0200) Apr 25 09:21:24.240 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:21:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:21:24 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:21:31 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:21:37 (+0200) 25.04.23 11:21:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:21:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:535727µs) - drift=105µs 25.04.23 11:21:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:21:37 (+0200) 25.04.23 11:21:40 (+0200) 2023-04-25 09:21:40,853 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:21:40 (+0200) 2023-04-25 09:21:40,854 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:21:41 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:21:43 (+0200) 2023-04-25 09:21:43,347 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:21:43 (+0200) 2023-04-25 09:21:43,348 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:21:43 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:21:43 (+0200) 2023-04-25 09:21:43,969 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:21:43 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:21:43 (+0200) 2023-04-25 09:21:43,971 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:21:43 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:21:43 (+0200) 2023-04-25 09:21:43,974 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:21:43 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:21:43 (+0200) 2023-04-25 09:21:43,986 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:21:43 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:21:44 (+0200) 2023-04-25 09:21:43,987 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:21:44 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:21:44 (+0200) 2023-04-25 09:21:44,001 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:21:44 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:21:44 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:21:44 (+0200) INFO:root:Diagnostics complete 25.04.23 11:21:44 (+0200) 2023-04-25 09:21:44,019 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:21:51 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:21:54 (+0200) 25.04.23 11:21:54 (+0200) ##### 2023-04-25 09:21:54 GMT ##### 25.04.23 11:21:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:21:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:21:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:21:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:21:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:21:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:21:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:21:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:21:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:21:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:21:54 (+0200) # TX errors: 0 25.04.23 11:21:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:21:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:21:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:21:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:21:54 (+0200) # BEACON queued: 0 25.04.23 11:21:54 (+0200) # BEACON sent so far: 0 25.04.23 11:21:54 (+0200) # BEACON rejected: 0 25.04.23 11:21:54 (+0200) ### [JIT] ### 25.04.23 11:21:54 (+0200) # SX1301 time (PPS): 1834968447 25.04.23 11:21:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:21:54 (+0200) ### [GPS] ### 25.04.23 11:21:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:21:54 (+0200) ##### END ##### 25.04.23 11:21:54 (+0200) 25.04.23 11:21:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:21:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:21:54 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:21:54 (+0200) Apr 25 09:21:54.250 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:21:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:22:02 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:22:10 (+0200) 2023-04-25 09:22:10,856 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:22:10 (+0200) 2023-04-25 09:22:10,857 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:22:12 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:22:22 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:22:24 (+0200) 25.04.23 11:22:24 (+0200) ##### 2023-04-25 09:22:24 GMT ##### 25.04.23 11:22:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:22:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:22:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:22:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:22:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:22:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:22:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:22:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:22:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:22:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:22:24 (+0200) # TX errors: 0 25.04.23 11:22:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:22:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:22:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:22:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:22:24 (+0200) # BEACON queued: 0 25.04.23 11:22:24 (+0200) # BEACON sent so far: 0 25.04.23 11:22:24 (+0200) # BEACON rejected: 0 25.04.23 11:22:24 (+0200) ### [JIT] ### 25.04.23 11:22:24 (+0200) # SX1301 time (PPS): 1834968447 25.04.23 11:22:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:22:24 (+0200) ### [GPS] ### 25.04.23 11:22:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:22:24 (+0200) ##### END ##### 25.04.23 11:22:24 (+0200) 25.04.23 11:22:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:22:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:22:24 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:22:24 (+0200) Apr 25 09:22:24.246 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:22:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:22:32 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:22:37 (+0200) 25.04.23 11:22:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:22:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:535846µs) - drift=119µs 25.04.23 11:22:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:22:37 (+0200) 25.04.23 11:22:40 (+0200) 2023-04-25 09:22:40,859 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:22:40 (+0200) 2023-04-25 09:22:40,860 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:22:42 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,021 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,022 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:22:44 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:22:44 (+0200) Exception in thread Thread-27357 (_run): 25.04.23 11:22:44 (+0200) Traceback (most recent call last): 25.04.23 11:22:44 (+0200) File "/usr/local/lib/python3.11/threading.py", line 1038, in _bootstrap_inner 25.04.23 11:22:44 (+0200) self.run() 25.04.23 11:22:44 (+0200) File "/usr/local/lib/python3.11/threading.py", line 975, in run 25.04.23 11:22:44 (+0200) self._target(*self._args, **self._kwargs) 25.04.23 11:22:44 (+0200) File "src/python/grpcio/grpc/_cython/_cygrpc/thread.pyx.pxi", line 53, in grpc._cython.cygrpc._run_with_context._run 25.04.23 11:22:44 (+0200) File "/opt/python-dependencies/grpc/_channel.py", line 1547, in _poll_connectivity 25.04.23 11:22:44 (+0200) event = channel.watch_connectivity_state(connectivity, 25.04.23 11:22:44 (+0200) ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^ 25.04.23 11:22:44 (+0200) File "src/python/grpcio/grpc/_cython/_cygrpc/channel.pyx.pxi", line 510, in grpc._cython.cygrpc.Channel.watch_connectivity_state 25.04.23 11:22:44 (+0200) File "src/python/grpcio/grpc/_cython/_cygrpc/channel.pyx.pxi", line 377, in grpc._cython.cygrpc._watch_connectivity_state 25.04.23 11:22:44 (+0200) File "src/python/grpcio/grpc/_cython/_cygrpc/channel.pyx.pxi", line 385, in grpc._cython.cygrpc._watch_connectivity_state 25.04.23 11:22:44 (+0200) ValueError: Cannot monitor channel state: Channel closed! 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,435 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:22:44 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,436 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:22:44 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,442 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:22:44 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,470 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:22:44 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,472 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:22:44 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,488 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:22:44 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:22:44 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:22:44 (+0200) INFO:root:Diagnostics complete 25.04.23 11:22:44 (+0200) 2023-04-25 09:22:44,509 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:22:52 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:22:54 (+0200) 25.04.23 11:22:54 (+0200) ##### 2023-04-25 09:22:54 GMT ##### 25.04.23 11:22:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:22:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:22:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:22:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:22:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:22:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:22:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:22:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:22:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:22:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:22:54 (+0200) # TX errors: 0 25.04.23 11:22:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:22:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:22:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:22:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:22:54 (+0200) # BEACON queued: 0 25.04.23 11:22:54 (+0200) # BEACON sent so far: 0 25.04.23 11:22:54 (+0200) # BEACON rejected: 0 25.04.23 11:22:54 (+0200) ### [JIT] ### 25.04.23 11:22:54 (+0200) # SX1301 time (PPS): 1894969565 25.04.23 11:22:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:22:54 (+0200) ### [GPS] ### 25.04.23 11:22:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:22:54 (+0200) ##### END ##### 25.04.23 11:22:54 (+0200) 25.04.23 11:22:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:22:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:22:54 (+0200) Apr 25 09:22:54.248 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:22:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:22:54 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:23:02 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:23:10 (+0200) 2023-04-25 09:23:10,862 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:23:10 (+0200) 2023-04-25 09:23:10,863 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:23:12 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:23:23 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:23:24 (+0200) 25.04.23 11:23:24 (+0200) ##### 2023-04-25 09:23:24 GMT ##### 25.04.23 11:23:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:23:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:23:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:23:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:23:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:23:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:23:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:23:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:23:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:23:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:23:24 (+0200) # TX errors: 0 25.04.23 11:23:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:23:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:23:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:23:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:23:24 (+0200) # BEACON queued: 0 25.04.23 11:23:24 (+0200) # BEACON sent so far: 0 25.04.23 11:23:24 (+0200) # BEACON rejected: 0 25.04.23 11:23:24 (+0200) ### [JIT] ### 25.04.23 11:23:24 (+0200) # SX1301 time (PPS): 1894969565 25.04.23 11:23:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:23:24 (+0200) ### [GPS] ### 25.04.23 11:23:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:23:24 (+0200) ##### END ##### 25.04.23 11:23:24 (+0200) 25.04.23 11:23:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:23:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:23:24 (+0200) Apr 25 09:23:24.252 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:23:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:23:24 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:23:33 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:23:37 (+0200) 25.04.23 11:23:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:23:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:535982µs) - drift=136µs 25.04.23 11:23:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:23:37 (+0200) 25.04.23 11:23:40 (+0200) 2023-04-25 09:23:40,866 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:23:40 (+0200) 2023-04-25 09:23:40,867 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:23:43 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:23:44 (+0200) 2023-04-25 09:23:44,510 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:23:44 (+0200) 2023-04-25 09:23:44,511 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:23:44 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,147 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:23:45 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,149 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:23:45 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,152 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:23:45 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,165 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:23:45 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,166 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:23:45 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,175 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:23:45 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:23:45 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:23:45 (+0200) INFO:root:Diagnostics complete 25.04.23 11:23:45 (+0200) 2023-04-25 09:23:45,191 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:23:53 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:23:54 (+0200) 25.04.23 11:23:54 (+0200) ##### 2023-04-25 09:23:54 GMT ##### 25.04.23 11:23:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:23:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:23:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:23:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:23:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:23:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:23:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:23:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:23:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:23:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:23:54 (+0200) Apr 25 09:23:54.249 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:23:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:23:54 (+0200) # TX errors: 0 25.04.23 11:23:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:23:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:23:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:23:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:23:54 (+0200) # BEACON queued: 0 25.04.23 11:23:54 (+0200) # BEACON sent so far: 0 25.04.23 11:23:54 (+0200) # BEACON rejected: 0 25.04.23 11:23:54 (+0200) ### [JIT] ### 25.04.23 11:23:54 (+0200) # SX1301 time (PPS): 1954970314 25.04.23 11:23:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:23:54 (+0200) ### [GPS] ### 25.04.23 11:23:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:23:54 (+0200) ##### END ##### 25.04.23 11:23:54 (+0200) 25.04.23 11:23:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:23:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:23:54 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:24:03 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:24:10 (+0200) 2023-04-25 09:24:10,870 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:24:10 (+0200) 2023-04-25 09:24:10,870 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:24:13 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:24:23 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:24:24 (+0200) 25.04.23 11:24:24 (+0200) ##### 2023-04-25 09:24:24 GMT ##### 25.04.23 11:24:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:24:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:24:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:24:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:24:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:24:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:24:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:24:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:24:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:24:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:24:24 (+0200) # TX errors: 0 25.04.23 11:24:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:24:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:24:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:24:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:24:24 (+0200) # BEACON queued: 0 25.04.23 11:24:24 (+0200) # BEACON sent so far: 0 25.04.23 11:24:24 (+0200) # BEACON rejected: 0 25.04.23 11:24:24 (+0200) ### [JIT] ### 25.04.23 11:24:24 (+0200) # SX1301 time (PPS): 1954970314 25.04.23 11:24:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:24:24 (+0200) ### [GPS] ### 25.04.23 11:24:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:24:24 (+0200) ##### END ##### 25.04.23 11:24:24 (+0200) 25.04.23 11:24:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:24:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:24:24 (+0200) Apr 25 09:24:24.253 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:24:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:24:24 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:24:34 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:24:37 (+0200) 25.04.23 11:24:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:24:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:536127µs) - drift=145µs 25.04.23 11:24:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:24:37 (+0200) 25.04.23 11:24:40 (+0200) 2023-04-25 09:24:40,873 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:24:40 (+0200) 2023-04-25 09:24:40,874 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:24:44 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,193 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,193 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:24:45 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,847 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:24:45 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,848 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:24:45 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,851 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:24:45 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,867 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:24:45 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,869 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:24:45 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,886 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:24:45 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:24:45 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:24:45 (+0200) INFO:root:Diagnostics complete 25.04.23 11:24:45 (+0200) 2023-04-25 09:24:45,902 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:24:54 (+0200) 25.04.23 11:24:54 (+0200) ##### 2023-04-25 09:24:54 GMT ##### 25.04.23 11:24:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:24:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:24:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:24:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:24:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:24:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:24:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:24:54 (+0200) # PULL_DATA sent: 2 (100.00% acknowledged) 25.04.23 11:24:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:24:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:24:54 (+0200) Apr 25 09:24:54.258 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:24:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:24:54 (+0200) # TX errors: 0 25.04.23 11:24:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:24:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:24:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:24:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:24:54 (+0200) # BEACON queued: 0 25.04.23 11:24:54 (+0200) # BEACON sent so far: 0 25.04.23 11:24:54 (+0200) # BEACON rejected: 0 25.04.23 11:24:54 (+0200) ### [JIT] ### 25.04.23 11:24:54 (+0200) # SX1301 time (PPS): 2014971005 25.04.23 11:24:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:24:54 (+0200) ### [GPS] ### 25.04.23 11:24:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:24:54 (+0200) ##### END ##### 25.04.23 11:24:54 (+0200) 25.04.23 11:24:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:24:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:24:54 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:24:54 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:25:04 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:25:10 (+0200) 2023-04-25 09:25:10,876 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:25:10 (+0200) 2023-04-25 09:25:10,877 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:25:14 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:25:24 (+0200) 25.04.23 11:25:24 (+0200) ##### 2023-04-25 09:25:24 GMT ##### 25.04.23 11:25:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:25:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:25:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:25:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:25:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:25:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:25:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:25:24 (+0200) Apr 25 09:25:24.254 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:25:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:25:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:25:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:25:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:25:24 (+0200) # TX errors: 0 25.04.23 11:25:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:25:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:25:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:25:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:25:24 (+0200) # BEACON queued: 0 25.04.23 11:25:24 (+0200) # BEACON sent so far: 0 25.04.23 11:25:24 (+0200) # BEACON rejected: 0 25.04.23 11:25:24 (+0200) ### [JIT] ### 25.04.23 11:25:24 (+0200) # SX1301 time (PPS): 2014971005 25.04.23 11:25:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:25:24 (+0200) ### [GPS] ### 25.04.23 11:25:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:25:24 (+0200) ##### END ##### 25.04.23 11:25:24 (+0200) 25.04.23 11:25:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:25:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:25:24 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:25:24 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:25:26 (+0200) DEBUG:apscheduler.scheduler:Looking for jobs to run 25.04.23 11:25:26 (+0200) DEBUG:apscheduler.scheduler:Next wakeup is due at 2023-04-25 09:26:55.558854+00:00 (in 88.734464 seconds) 25.04.23 11:25:26 (+0200) INFO:apscheduler.executors.default:Running job "quectel_repeating (trigger: interval[1:00:00], next run at: 2023-04-25 10:25:26 UTC)" (scheduled at 2023-04-25 09:25:26.821435+00:00) 25.04.23 11:25:29 (+0200) 2023-04-25 09:25:29,903 - [INFO] - hw_diag.utilities.quectel - (quectel.py).reset_modem_manager -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(142) - modem manager restarted: True 25.04.23 11:25:29 (+0200) INFO:hw_diag.utilities.quectel:modem manager restarted: True 25.04.23 11:25:29 (+0200) 2023-04-25 09:25:29,904 - [INFO] - hw_diag.utilities.quectel - (quectel.py).reset_modem_manager -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(143) - waiting 120 seconds for the modem manager to pick the modem again 25.04.23 11:25:29 (+0200) INFO:hw_diag.utilities.quectel:waiting 120 seconds for the modem manager to pick the modem again 25.04.23 11:25:34 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:25:37 (+0200) 25.04.23 11:25:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:25:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:536280µs) - drift=153µs 25.04.23 11:25:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:25:37 (+0200) 25.04.23 11:25:40 (+0200) 2023-04-25 09:25:40,880 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:25:40 (+0200) 2023-04-25 09:25:40,881 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:25:45 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:25:45 (+0200) 2023-04-25 09:25:45,904 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:25:45 (+0200) 2023-04-25 09:25:45,905 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:25:45 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,522 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:25:46 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,524 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:25:46 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,529 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:25:46 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,544 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:25:46 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,546 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:25:46 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,558 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:25:46 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:25:46 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:25:46 (+0200) INFO:root:Diagnostics complete 25.04.23 11:25:46 (+0200) 2023-04-25 09:25:46,572 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:25:54 (+0200) 25.04.23 11:25:54 (+0200) ##### 2023-04-25 09:25:54 GMT ##### 25.04.23 11:25:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:25:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:25:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:25:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:25:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:25:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:25:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:25:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:25:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:25:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:25:54 (+0200) # TX errors: 0 25.04.23 11:25:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:25:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:25:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:25:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:25:54 (+0200) # BEACON queued: 0 25.04.23 11:25:54 (+0200) # BEACON sent so far: 0 25.04.23 11:25:54 (+0200) # BEACON rejected: 0 25.04.23 11:25:54 (+0200) ### [JIT] ### 25.04.23 11:25:54 (+0200) # SX1301 time (PPS): 2074971566 25.04.23 11:25:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:25:54 (+0200) ### [GPS] ### 25.04.23 11:25:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:25:54 (+0200) ##### END ##### 25.04.23 11:25:54 (+0200) 25.04.23 11:25:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:25:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:25:54 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:25:54 (+0200) Apr 25 09:25:54.257 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:25:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:25:55 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:05 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:10 (+0200) 2023-04-25 09:26:10,883 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:26:10 (+0200) 2023-04-25 09:26:10,884 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:26:15 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:24 (+0200) 25.04.23 11:26:24 (+0200) ##### 2023-04-25 09:26:24 GMT ##### 25.04.23 11:26:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:26:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:26:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:26:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:26:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:26:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:26:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:26:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:26:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:26:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:26:24 (+0200) # TX errors: 0 25.04.23 11:26:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:26:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:26:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:26:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:26:24 (+0200) # BEACON queued: 0 25.04.23 11:26:24 (+0200) # BEACON sent so far: 0 25.04.23 11:26:24 (+0200) # BEACON rejected: 0 25.04.23 11:26:24 (+0200) ### [JIT] ### 25.04.23 11:26:24 (+0200) # SX1301 time (PPS): 2074971566 25.04.23 11:26:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:26:24 (+0200) ### [GPS] ### 25.04.23 11:26:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:26:24 (+0200) ##### END ##### 25.04.23 11:26:24 (+0200) 25.04.23 11:26:24 (+0200) Apr 25 09:26:24.266 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:26:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:26:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:26:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:26:24 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:26:25 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:35 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:37 (+0200) 25.04.23 11:26:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:26:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:536438µs) - drift=158µs 25.04.23 11:26:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:26:37 (+0200) 25.04.23 11:26:40 (+0200) 2023-04-25 09:26:40,886 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:26:40 (+0200) 2023-04-25 09:26:40,887 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:26:45 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:46 (+0200) 2023-04-25 09:26:46,573 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:26:46 (+0200) 2023-04-25 09:26:46,574 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:26:46 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,201 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:26:47 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,202 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:26:47 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,207 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:26:47 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,220 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:26:47 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,221 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:26:47 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,236 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:26:47 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:26:47 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:26:47 (+0200) INFO:root:Diagnostics complete 25.04.23 11:26:47 (+0200) 2023-04-25 09:26:47,254 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:26:54 (+0200) 25.04.23 11:26:54 (+0200) ##### 2023-04-25 09:26:54 GMT ##### 25.04.23 11:26:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:26:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:26:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:26:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:26:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:26:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:26:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:26:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:26:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:26:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:26:54 (+0200) # TX errors: 0 25.04.23 11:26:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:26:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:26:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:26:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:26:54 (+0200) # BEACON queued: 0 25.04.23 11:26:54 (+0200) # BEACON sent so far: 0 25.04.23 11:26:54 (+0200) # BEACON rejected: 0 25.04.23 11:26:54 (+0200) ### [JIT] ### 25.04.23 11:26:54 (+0200) # SX1301 time (PPS): 2134972629 25.04.23 11:26:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:26:54 (+0200) ### [GPS] ### 25.04.23 11:26:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:26:54 (+0200) ##### END ##### 25.04.23 11:26:54 (+0200) 25.04.23 11:26:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:26:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:26:54 (+0200) Apr 25 09:26:54.273 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:26:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:26:54 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:26:55 (+0200) DEBUG:apscheduler.scheduler:Looking for jobs to run 25.04.23 11:26:55 (+0200) DEBUG:apscheduler.scheduler:Next wakeup is due at 2023-04-25 10:14:29.499170+00:00 (in 2853.937201 seconds) 25.04.23 11:26:55 (+0200) INFO:apscheduler.executors.default:Running job "ship_diagnostics (trigger: interval[1:00:00], next run at: 2023-04-25 10:28:35 UTC)" (scheduled at 2023-04-25 09:26:55.558854+00:00) 25.04.23 11:26:55 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:26:55 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:26:56 (+0200) 2023-04-25 09:26:56,124 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:26:56 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:26:56 (+0200) 2023-04-25 09:26:56,125 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:26:56 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:26:56 (+0200) 2023-04-25 09:26:56,127 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:26:56 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:26:56 (+0200) 2023-04-25 09:26:56,139 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:26:56 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:26:56 (+0200) 2023-04-25 09:26:56,141 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:26:56 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:26:56 (+0200) 2023-04-25 09:26:56,155 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:26:56 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:26:56 (+0200) INFO:root:Submitting diagnostics to GCS bucket - helium-miner-data 25.04.23 11:26:56 (+0200) DEBUG:urllib3.connectionpool:Starting new HTTPS connection (1): www.googleapis.com:443 25.04.23 11:26:56 (+0200) DEBUG:urllib3.connectionpool:https://www.googleapis.com:443 "POST /upload/storage/v1/b/helium-miner-data/o?uploadType=media&name=abf76faa1d3cd853cab9f1187a7c7ebd402c1b0207b9e3b1d0f207d8feab0c41 HTTP/1.1" 200 968 25.04.23 11:26:56 (+0200) INFO:root:Diagnostics Submitted to GCS Bucket Successfully 25.04.23 11:26:56 (+0200) INFO:root:Diagnostics complete 25.04.23 11:26:56 (+0200) INFO:apscheduler.executors.default:Job "ship_diagnostics (trigger: interval[1:00:00], next run at: 2023-04-25 10:28:35 UTC)" executed successfully 25.04.23 11:27:06 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:27:10 (+0200) 2023-04-25 09:27:10,890 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:27:10 (+0200) 2023-04-25 09:27:10,891 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:27:16 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:27:24 (+0200) 25.04.23 11:27:24 (+0200) ##### 2023-04-25 09:27:24 GMT ##### 25.04.23 11:27:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:27:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:27:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:27:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:27:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:27:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:27:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:27:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:27:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:27:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:27:24 (+0200) # TX errors: 0 25.04.23 11:27:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:27:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:27:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:27:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:27:24 (+0200) # BEACON queued: 0 25.04.23 11:27:24 (+0200) # BEACON sent so far: 0 25.04.23 11:27:24 (+0200) # BEACON rejected: 0 25.04.23 11:27:24 (+0200) ### [JIT] ### 25.04.23 11:27:24 (+0200) # SX1301 time (PPS): 2134972629 25.04.23 11:27:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:27:24 (+0200) ### [GPS] ### 25.04.23 11:27:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:27:24 (+0200) ##### END ##### 25.04.23 11:27:24 (+0200) 25.04.23 11:27:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:27:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:27:24 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:27:24 (+0200) Apr 25 09:27:24.265 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:27:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:27:26 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:27:29 (+0200) 2023-04-25 09:27:29,917 - [INFO] - hw_diag.utilities.quectel - (quectel.py).ensure_quectel_health -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(394) - lets ensure that UE_MODE is set to DATA_CENTRIC 25.04.23 11:27:29 (+0200) INFO:hw_diag.utilities.quectel:lets ensure that UE_MODE is set to DATA_CENTRIC 25.04.23 11:27:29 (+0200) 2023-04-25 09:27:29,930 - [DEBUG] - hw_diag.utilities.quectel - (quectel.py).update_setting_with_rollback -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(257) - EG25G modem not found 25.04.23 11:27:29 (+0200) DEBUG:hw_diag.utilities.quectel:EG25G modem not found 25.04.23 11:27:29 (+0200) 2023-04-25 09:27:29,930 - [INFO] - hw_diag.utilities.quectel - (quectel.py).ensure_quectel_health -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(396) - lets ensure that service domain is PS 25.04.23 11:27:29 (+0200) INFO:hw_diag.utilities.quectel:lets ensure that service domain is PS 25.04.23 11:27:29 (+0200) 2023-04-25 09:27:29,939 - [DEBUG] - hw_diag.utilities.quectel - (quectel.py).update_setting_with_rollback -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(257) - EG25G modem not found 25.04.23 11:27:29 (+0200) DEBUG:hw_diag.utilities.quectel:EG25G modem not found 25.04.23 11:27:29 (+0200) 2023-04-25 09:27:29,940 - [INFO] - hw_diag.utilities.quectel - (quectel.py).ensure_quectel_health -- /opt/python-dependencies/hw_diag/utilities/quectel.py:(404) - skipping quectel firmware update because UPDATE_QUECTEL_EG25G_MODEM is not set 25.04.23 11:27:29 (+0200) INFO:hw_diag.utilities.quectel:skipping quectel firmware update because UPDATE_QUECTEL_EG25G_MODEM is not set 25.04.23 11:27:29 (+0200) INFO:apscheduler.executors.default:Job "quectel_repeating (trigger: interval[1:00:00], next run at: 2023-04-25 10:25:26 UTC)" executed successfully 25.04.23 11:27:36 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:27:37 (+0200) 25.04.23 11:27:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:27:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:536600µs) - drift=162µs 25.04.23 11:27:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:27:37 (+0200) 25.04.23 11:27:40 (+0200) 2023-04-25 09:27:40,893 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:27:40 (+0200) 2023-04-25 09:27:40,894 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:27:46 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,256 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,257 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:27:47 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,880 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:27:47 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,881 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:27:47 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,887 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:27:47 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,901 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:27:47 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,903 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:27:47 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,916 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:27:47 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:27:47 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:27:47 (+0200) INFO:root:Diagnostics complete 25.04.23 11:27:47 (+0200) 2023-04-25 09:27:47,935 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:27:54 (+0200) 25.04.23 11:27:54 (+0200) ##### 2023-04-25 09:27:54 GMT ##### 25.04.23 11:27:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:27:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:27:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:27:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:27:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:27:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:27:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:27:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:27:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:27:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:27:54 (+0200) # TX errors: 0 25.04.23 11:27:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:27:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:27:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:27:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:27:54 (+0200) # BEACON queued: 0 25.04.23 11:27:54 (+0200) # BEACON sent so far: 0 25.04.23 11:27:54 (+0200) # BEACON rejected: 0 25.04.23 11:27:54 (+0200) ### [JIT] ### 25.04.23 11:27:54 (+0200) # SX1301 time (PPS): 2194973835 25.04.23 11:27:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:27:54 (+0200) ### [GPS] ### 25.04.23 11:27:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:27:54 (+0200) ##### END ##### 25.04.23 11:27:54 (+0200) Apr 25 09:27:54.273 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:27:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:27:54 (+0200) 25.04.23 11:27:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:27:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:27:54 (+0200) INFO: [up] PUSH_ACK received in 6 ms 25.04.23 11:27:56 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:28:07 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:28:10 (+0200) 2023-04-25 09:28:10,898 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:28:10 (+0200) 2023-04-25 09:28:10,899 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:28:17 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:28:24 (+0200) 25.04.23 11:28:24 (+0200) ##### 2023-04-25 09:28:24 GMT ##### 25.04.23 11:28:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:28:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:28:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:28:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:28:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:28:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:28:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:28:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:28:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:28:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:28:24 (+0200) # TX errors: 0 25.04.23 11:28:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:28:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:28:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:28:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:28:24 (+0200) # BEACON queued: 0 25.04.23 11:28:24 (+0200) # BEACON sent so far: 0 25.04.23 11:28:24 (+0200) # BEACON rejected: 0 25.04.23 11:28:24 (+0200) ### [JIT] ### 25.04.23 11:28:24 (+0200) # SX1301 time (PPS): 2194973835 25.04.23 11:28:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:28:24 (+0200) ### [GPS] ### 25.04.23 11:28:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:28:24 (+0200) ##### END ##### 25.04.23 11:28:24 (+0200) Apr 25 09:28:24.273 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:28:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:28:24 (+0200) 25.04.23 11:28:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:28:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:28:24 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:28:27 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:28:37 (+0200) 25.04.23 11:28:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:28:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:536774µs) - drift=174µs 25.04.23 11:28:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:28:37 (+0200) 25.04.23 11:28:37 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:28:40 (+0200) 2023-04-25 09:28:40,901 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:28:40 (+0200) 2023-04-25 09:28:40,902 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:28:47 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:28:47 (+0200) 2023-04-25 09:28:47,936 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:28:47 (+0200) 2023-04-25 09:28:47,937 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:28:47 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,557 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:28:48 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,559 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:28:48 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,564 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:28:48 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,574 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:28:48 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,575 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:28:48 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,590 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:28:48 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:28:48 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:28:48 (+0200) INFO:root:Diagnostics complete 25.04.23 11:28:48 (+0200) 2023-04-25 09:28:48,607 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:28:54 (+0200) 25.04.23 11:28:54 (+0200) ##### 2023-04-25 09:28:54 GMT ##### 25.04.23 11:28:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:28:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:28:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:28:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:28:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:28:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:28:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:28:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:28:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:28:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:28:54 (+0200) # TX errors: 0 25.04.23 11:28:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:28:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:28:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:28:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:28:54 (+0200) # BEACON queued: 0 25.04.23 11:28:54 (+0200) # BEACON sent so far: 0 25.04.23 11:28:54 (+0200) # BEACON rejected: 0 25.04.23 11:28:54 (+0200) ### [JIT] ### 25.04.23 11:28:54 (+0200) # SX1301 time (PPS): 2254974430 25.04.23 11:28:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:28:54 (+0200) ### [GPS] ### 25.04.23 11:28:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:28:54 (+0200) ##### END ##### 25.04.23 11:28:54 (+0200) 25.04.23 11:28:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:28:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:28:54 (+0200) Apr 25 09:28:54.279 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:28:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:28:54 (+0200) INFO: [up] PUSH_ACK received in 3 ms 25.04.23 11:28:57 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:29:07 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:29:10 (+0200) 2023-04-25 09:29:10,905 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:29:10 (+0200) 2023-04-25 09:29:10,906 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:29:17 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:29:24 (+0200) 25.04.23 11:29:24 (+0200) ##### 2023-04-25 09:29:24 GMT ##### 25.04.23 11:29:24 (+0200) ### [UPSTREAM] ### 25.04.23 11:29:24 (+0200) # RF packets received by concentrator: 0 25.04.23 11:29:24 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:29:24 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:29:24 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:29:24 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:29:24 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:29:24 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:29:24 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:29:24 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:29:24 (+0200) # TX errors: 0 25.04.23 11:29:24 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:29:24 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:29:24 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:29:24 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:29:24 (+0200) # BEACON queued: 0 25.04.23 11:29:24 (+0200) # BEACON sent so far: 0 25.04.23 11:29:24 (+0200) # BEACON rejected: 0 25.04.23 11:29:24 (+0200) ### [JIT] ### 25.04.23 11:29:24 (+0200) # SX1301 time (PPS): 2254974430 25.04.23 11:29:24 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:29:24 (+0200) ### [GPS] ### 25.04.23 11:29:24 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:29:24 (+0200) ##### END ##### 25.04.23 11:29:24 (+0200) 25.04.23 11:29:24 (+0200) Apr 25 09:29:24.285 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:29:24 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:29:24 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:29:24 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:29:24 (+0200) INFO: [up] PUSH_ACK received in 0 ms 25.04.23 11:29:27 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:29:37 (+0200) 25.04.23 11:29:37 (+0200) INFO: Disabling GPS mode for concentrator's counter... 25.04.23 11:29:37 (+0200) INFO: host/sx1301 time offset=(1682412662s:536948µs) - drift=174µs 25.04.23 11:29:37 (+0200) INFO: Enabling GPS mode for concentrator's counter. 25.04.23 11:29:37 (+0200) 25.04.23 11:29:38 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:29:40 (+0200) 2023-04-25 09:29:40,908 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(386) - No region override set (value = None), will retrieve from miner. 25.04.23 11:29:40 (+0200) 2023-04-25 09:29:40,909 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(390) - Region EU868 parsed from /var/pktfwd/region 25.04.23 11:29:48 (+0200) INFO: [down] PULL_ACK received in 0 ms 25.04.23 11:29:48 (+0200) 2023-04-25 09:29:48,608 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor 25.04.23 11:29:48 (+0200) 2023-04-25 09:29:48,609 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json 25.04.23 11:29:48 (+0200) INFO:root:Running periodic hardware diagnostics 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,231 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:29:49 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n "key": "112jjsPhNaCjQ7KaUccaY4pTCFxp4t6BTQmgct2tBh8Wf9nn1eH6",\n "name": "sleepy-vanilla-kookaburra"\n}\n' 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,234 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b'' 25.04.23 11:29:49 (+0200) INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b'' 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,237 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(83) - Retrieving list of BLE device(s) 25.04.23 11:29:49 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s) 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,251 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(103) - Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:29:49 (+0200) INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': '08:FB:EA:E0:5A:F7', 'Name': 'nebra-B9CF43.local', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}] 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,252 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(149) - Retrieving list of LTE device(s) 25.04.23 11:29:49 (+0200) INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s) 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,264 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/hw_diag/utilities/hardware.py:(176) - Found the following LTE Devices: [] 25.04.23 11:29:49 (+0200) INFO:hw_diag.utilities.hardware:Found the following LTE Devices: [] 25.04.23 11:29:49 (+0200) INFO:root:Diagnostics shipping not requested, skipping. 25.04.23 11:29:49 (+0200) INFO:root:Diagnostics complete 25.04.23 11:29:49 (+0200) 2023-04-25 09:29:49,283 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/gatewayconfig/processors/diagnostics_processor.py:(57) - 25.04.23 11:29:54 (+0200) 25.04.23 11:29:54 (+0200) ##### 2023-04-25 09:29:54 GMT ##### 25.04.23 11:29:54 (+0200) ### [UPSTREAM] ### 25.04.23 11:29:54 (+0200) # RF packets received by concentrator: 0 25.04.23 11:29:54 (+0200) # CRC_OK: 0.00%, CRC_FAIL: 0.00%, NO_CRC: 0.00% 25.04.23 11:29:54 (+0200) # RF packets forwarded: 0 (0 bytes) 25.04.23 11:29:54 (+0200) # PUSH_DATA datagrams sent: 1 (152 bytes) 25.04.23 11:29:54 (+0200) # PUSH_DATA acknowledged: 100.00% 25.04.23 11:29:54 (+0200) ### [DOWNSTREAM] ### 25.04.23 11:29:54 (+0200) # PULL_DATA sent: 3 (100.00% acknowledged) 25.04.23 11:29:54 (+0200) # PULL_RESP(onse) datagrams received: 0 (0 bytes) 25.04.23 11:29:54 (+0200) # RF packets sent to concentrator: 0 (0 bytes) 25.04.23 11:29:54 (+0200) # TX errors: 0 25.04.23 11:29:54 (+0200) # TX rejected (collision packet): 0.00% (req:10, rej:0) 25.04.23 11:29:54 (+0200) # TX rejected (collision beacon): 0.00% (req:10, rej:0) 25.04.23 11:29:54 (+0200) # TX rejected (too late): 0.00% (req:10, rej:0) 25.04.23 11:29:54 (+0200) # TX rejected (too early): 0.00% (req:10, rej:0) 25.04.23 11:29:54 (+0200) # BEACON queued: 0 25.04.23 11:29:54 (+0200) # BEACON sent so far: 0 25.04.23 11:29:54 (+0200) # BEACON rejected: 0 25.04.23 11:29:54 (+0200) ### [JIT] ### 25.04.23 11:29:54 (+0200) # SX1301 time (PPS): 2314975002 25.04.23 11:29:54 (+0200) src/jitqueue.c:448:jit_print_queue(): INFO: [jit] queue is empty 25.04.23 11:29:54 (+0200) ### [GPS] ### 25.04.23 11:29:54 (+0200) # GPS *FAKE* coordinates: latitude 0.00000, longitude 0.00000, altitude 0 m 25.04.23 11:29:54 (+0200) ##### END ##### 25.04.23 11:29:54 (+0200) 25.04.23 11:29:54 (+0200) JSON up: {"stat":{"time":"2023-04-25 09:29:54 GMT","lati":0.00000,"long":0.00000,"alti":0,"rxnb":0,"rxok":0,"rxfw":0,"ackr":100.0,"dwnb":0,"txnb":0}} 25.04.23 11:29:54 (+0200) Apr 25 09:29:54.286 INFO From 00:00:B2:11:F1:B9:CF:43 received stat: Stat { time: "2023-04-25 09:29:54 GMT", lati: Some(0.0), long: Some(0.0), alti: Some(0), rxnb: 0, rxok: 0, rxfw: 0, ackr: Some(100.0), dwnb: 0, txnb: 0 } 25.04.23 11:29:54 (+0200) INFO: [up] PUSH_ACK received in 1 ms 25.04.23 11:29:58 (+0200) INFO: [down] PULL_ACK received in 0 ms