search

srcfl / srcful-gateway

Srcful energy gateway to connect your solar inverter and mine src-token
https://srcful.io
MIT License
3 stars 1 forks source link

Test the Helium gateway application #109

Closed h0bb3 closed 5 months ago

h0bb3 commented 5 months ago

This would ensure we can run the gw as a helium packet forwarder and an egw PoS miner.

h0bb3 commented 5 months ago

That is on a preconfigured helium device we just replace the firmware with ours including a packet forwarder.

davmoz commented 5 months ago

Added in https://github.com/srcfl/srcful-gateway/commit/808a30a08acbb16388da874ba340f11d0479292d

Logs from a successful init: 

damoaa@MB-01391 helium-miner % balena logs -t 7d98042
[Logs]    [2024-02-04T16:24:49.291Z] Supervisor starting
[Logs]    [2024-02-04T16:24:54.069Z] Creating volume 'miner-storage'
[Logs]    [2024-02-04T16:24:54.077Z] Creating volume 'pktfwdr'
[Logs]    [2024-02-04T16:24:54.089Z] Creating volume 'dbus'
[Logs]    [2024-02-04T16:24:54.099Z] Creating volume 'nebra'
[Logs]    [2024-02-04T16:24:54.105Z] Creating volume 'watchdog-log'
[Logs]    [2024-02-04T16:24:54.117Z] Creating volume 'srcful-data'
[Logs]    [2024-02-04T16:24:54.123Z] Creating network 'default'
[Logs]    [2024-02-04T16:24:54.593Z] Downloading image 'registry.balena.srcful.dev/v2/4618d6a4be22a8ac715ca968209eda67@sha256:c5a593301fee7bc1dd5cad5ac1b65bd0eb9c1cd7e50fdee0da7732bde956e3b0'
[Logs]    [2024-02-04T16:24:54.625Z] Downloading image 'registry.balena.srcful.dev/v2/e63e3a441e703019aaf0b69b655860e8@sha256:19af2cded6cb8826013a7c247cbe58f026c0410994b5159536a7c243da80a1c4'
[Logs]    [2024-02-04T16:24:54.648Z] Downloading image 'registry.balena.srcful.dev/v2/fc9ca3e884caf7a117083a365050985f@sha256:ad1f0b44c65aa9749e083174098bd4a82f97267a753d3032c0dd70ca89d52e23'
[Logs]    [2024-02-04T16:24:54.661Z] Downloading image 'registry.balena.srcful.dev/v2/5abf8080db991aa31e120f5bcfb1c751@sha256:f17648d2134d305046569eaa19d6dce6e48461bd022cc9f86203f807ea366e18'
[Logs]    [2024-02-04T16:24:54.680Z] Downloading image 'registry.balena.srcful.dev/v2/b34fa223f5eb91666a3907b99ed00403@sha256:cf35a386bf61eee0d3ca31f538ae10b08a07c52abc327e201f304ddfcaf01265'
[Logs]    [2024-02-04T16:24:54.695Z] Downloading image 'registry.balena.srcful.dev/v2/f53781f07af130e8bb3d9f73e686a641@sha256:d65c99af26f6798cbd8301ece4554630e3bc08116481cd23c24bbc2e41d3368f'
[Logs]    [2024-02-04T16:24:54.735Z] Downloading image 'registry.balena.srcful.dev/v2/fccf449f69079b55c80ae0bd46424917@sha256:890f4607bf00f27d9792b09eb8c8311c4f37ca5a1c899753859e8bef4920e39f'
[Logs]    [2024-02-04T16:24:54.772Z] Downloading image 'registry.balena.srcful.dev/v2/b878d523e0475107dec4ba5af4a62c16@sha256:b364b9b1867f656c82af278ce757a91e5755975bcf21e83f71bc2ffa99622282'
[Logs]    [2024-02-04T16:25:54.547Z] Downloaded image 'registry.balena.srcful.dev/v2/fc9ca3e884caf7a117083a365050985f@sha256:ad1f0b44c65aa9749e083174098bd4a82f97267a753d3032c0dd70ca89d52e23'
[Logs]    [2024-02-04T16:26:06.057Z] Downloaded image 'registry.balena.srcful.dev/v2/5abf8080db991aa31e120f5bcfb1c751@sha256:f17648d2134d305046569eaa19d6dce6e48461bd022cc9f86203f807ea366e18'
[Logs]    [2024-02-04T16:26:43.951Z] Downloaded image 'registry.balena.srcful.dev/v2/e63e3a441e703019aaf0b69b655860e8@sha256:19af2cded6cb8826013a7c247cbe58f026c0410994b5159536a7c243da80a1c4'
[Logs]    [2024-02-04T16:27:11.494Z] Downloaded image 'registry.balena.srcful.dev/v2/f53781f07af130e8bb3d9f73e686a641@sha256:d65c99af26f6798cbd8301ece4554630e3bc08116481cd23c24bbc2e41d3368f'
[Logs]    [2024-02-04T16:27:37.016Z] Downloaded image 'registry.balena.srcful.dev/v2/fccf449f69079b55c80ae0bd46424917@sha256:890f4607bf00f27d9792b09eb8c8311c4f37ca5a1c899753859e8bef4920e39f'
[Logs]    [2024-02-04T16:28:10.578Z] Downloaded image 'registry.balena.srcful.dev/v2/4618d6a4be22a8ac715ca968209eda67@sha256:c5a593301fee7bc1dd5cad5ac1b65bd0eb9c1cd7e50fdee0da7732bde956e3b0'
[Logs]    [2024-02-04T16:28:11.620Z] Downloaded image 'registry.balena.srcful.dev/v2/b878d523e0475107dec4ba5af4a62c16@sha256:b364b9b1867f656c82af278ce757a91e5755975bcf21e83f71bc2ffa99622282'
[Logs]    [2024-02-04T16:28:41.788Z] Downloaded image 'registry.balena.srcful.dev/v2/b34fa223f5eb91666a3907b99ed00403@sha256:cf35a386bf61eee0d3ca31f538ae10b08a07c52abc327e201f304ddfcaf01265'
[Logs]    [2024-02-04T16:28:42.397Z] Installing service 'web sha256:103717659a27aff232ad7779504ae42f6217e1ad5a33e82cabcca4425bb83052'
[Logs]    [2024-02-04T16:28:42.438Z] Installing service 'dbus-session sha256:5ce1dc1fad6f5463b34a40dc1ecb790280855fa69a3998efb8324a7bcf5d018f'
[Logs]    [2024-02-04T16:28:42.698Z] Installed service 'web sha256:103717659a27aff232ad7779504ae42f6217e1ad5a33e82cabcca4425bb83052'
[Logs]    [2024-02-04T16:28:42.700Z] Starting service 'web sha256:103717659a27aff232ad7779504ae42f6217e1ad5a33e82cabcca4425bb83052'
[Logs]    [2024-02-04T16:28:42.715Z] Installed service 'dbus-session sha256:5ce1dc1fad6f5463b34a40dc1ecb790280855fa69a3998efb8324a7bcf5d018f'
[Logs]    [2024-02-04T16:28:42.717Z] Starting service 'dbus-session sha256:5ce1dc1fad6f5463b34a40dc1ecb790280855fa69a3998efb8324a7bcf5d018f'
[Logs]    [2024-02-04T16:28:44.622Z] Started service 'dbus-session sha256:5ce1dc1fad6f5463b34a40dc1ecb790280855fa69a3998efb8324a7bcf5d018f'
[Logs]    [2024-02-04T16:28:45.020Z] Started service 'web sha256:103717659a27aff232ad7779504ae42f6217e1ad5a33e82cabcca4425bb83052'
[Logs]    [2024-02-04T16:28:44.591Z] [dbus-session] balenaBlocks dbus version: 0.0.2
[Logs]    [2024-02-04T16:28:44.601Z] [dbus-session] unix:path=/session/dbus/session_bus_socket,guid=86ad8fe8753897c3845639e265bfbb3c
[Logs]    [2024-02-04T16:28:44.591Z] [dbus-session] balenaBlocks dbus version: 0.0.2
[Logs]    [2024-02-04T16:28:44.601Z] [dbus-session] unix:path=/session/dbus/session_bus_socket,guid=86ad8fe8753897c3845639e265bfbb3c
[Logs]    [2024-02-04T16:28:45.719Z] Installing service 'diagnostics sha256:5ebb225b68718fbafd47fb0588364a54287d2161a347eb4a9f7437d96b6065ff'
[Logs]    [2024-02-04T16:28:45.742Z] Installing service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:28:46.046Z] Installed service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:28:46.048Z] Starting service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:28:46.069Z] Installed service 'diagnostics sha256:5ebb225b68718fbafd47fb0588364a54287d2161a347eb4a9f7437d96b6065ff'
[Logs]    [2024-02-04T16:28:46.074Z] Starting service 'diagnostics sha256:5ebb225b68718fbafd47fb0588364a54287d2161a347eb4a9f7437d96b6065ff'
[Logs]    [2024-02-04T16:28:46.316Z] [web] INFO:__main__:Running with the following configuration: Namespace(web_host='0.0.0.0', web_port=5000, inverter_host='localhost', inverter_port=502, inverter_type='unknown', inverter_address=1, bootstrap='/data/srcful/bootstrap.txt')
[Logs]    [2024-02-04T16:28:46.317Z] [web] INFO:server.app:eGW version: 0.6.1
[Logs]    [2024-02-04T16:28:46.327Z] [web] Server started http://0.0.0.0:5000
[Logs]    [2024-02-04T16:28:46.328Z] [web] ERROR:server.bootstrap:Failed to create file: /data/srcful/bootstrap.txt
[Logs]    [2024-02-04T16:28:46.328Z] [web] ERROR:server.bootstrap:[Errno 2] No such file or directory: '/data/srcful/bootstrap.txt'
[Logs]    [2024-02-04T16:28:46.569Z] [web] Scanned SSIDs: ['Orion_5G', 'TN-UV9879', 'Orion_testnet', 'iotlab', 'Orion', 'TN_5GHz_F55D95', 'TN-VA1229', 'TN_24GHz_F55D95']
[Logs]    [2024-02-04T16:28:46.570Z] [web] ERROR:server.bootstrap:Failed to read file: /data/srcful/bootstrap.txt
[Logs]    [2024-02-04T16:28:46.570Z] [web] ERROR:server.bootstrap:[Errno 2] No such file or directory: '/data/srcful/bootstrap.txt'
[Logs]    [2024-02-04T16:28:47.218Z] Started service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:28:47.165Z] [bluetooth] Starting bluetooth container...
[Logs]    [2024-02-04T16:28:47.192Z] [bluetooth] method return time=1707064127.188665 sender=:1.0 -> destination=:1.41 serial=1174 reply_serial=2
[Logs]    [2024-02-04T16:28:47.193Z] [bluetooth]    object path "/org/freedesktop/systemd1/job/3244"
[Logs]    [2024-02-04T16:28:47.165Z] [bluetooth] Starting bluetooth container...
[Logs]    [2024-02-04T16:28:47.192Z] [bluetooth] method return time=1707064127.188665 sender=:1.0 -> destination=:1.41 serial=1174 reply_serial=2
[Logs]    [2024-02-04T16:28:47.193Z] [bluetooth]    object path "/org/freedesktop/systemd1/job/3244"
[Logs]    [2024-02-04T16:28:47.312Z] [bluetooth] Starting system message bus: dbus.
[Logs]    [2024-02-04T16:28:48.844Z] Started service 'diagnostics sha256:5ebb225b68718fbafd47fb0588364a54287d2161a347eb4a9f7437d96b6065ff'
[Logs]    [2024-02-04T16:28:48.366Z] [bluetooth] Bluetooth agent started!
[Logs]    [2024-02-04T16:28:48.851Z] [diagnostics] FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:28:48.853Z] [diagnostics] FREQ parameter file doesn't exist. Setting it as N/A (Non Nebra Miner) now.
[Logs]    [2024-02-04T16:28:48.854Z] [diagnostics] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:28:48.855Z] [diagnostics] VARIANT parameter file doesn't exist. Setting it as COMP-RAKHM now.
[Logs]    [2024-02-04T16:28:49.740Z] Installing service 'helium-miner sha256:5d1be2726aac697b6099978d6870619521d9c0faf355ff59c59e6404c86f36ef'
[Logs]    [2024-02-04T16:28:48.851Z] [diagnostics] FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:28:48.853Z] [diagnostics] FREQ parameter file doesn't exist. Setting it as N/A (Non Nebra Miner) now.
[Logs]    [2024-02-04T16:28:48.854Z] [diagnostics] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:28:48.855Z] [diagnostics] VARIANT parameter file doesn't exist. Setting it as COMP-RAKHM now.
[Logs]    [2024-02-04T16:28:50.372Z] Installed service 'helium-miner sha256:5d1be2726aac697b6099978d6870619521d9c0faf355ff59c59e6404c86f36ef'
[Logs]    [2024-02-04T16:28:50.379Z] Starting service 'helium-miner sha256:5d1be2726aac697b6099978d6870619521d9c0faf355ff59c59e6404c86f36ef'
[Logs]    [2024-02-04T16:28:50.395Z] [bluetooth] Starting ble service... 
[Logs]    [2024-02-04T16:28:50.402Z] [bluetooth] DEBUG:asyncio:Using selector: EpollSelector
[Logs]    [2024-02-04T16:28:50.470Z] [bluetooth] DEBUG:__main__:Service added with uuid a07498ca-ad5b-474e-940d-16f1fbe7e8cd and name SrcFul Energy Gateway 370ddf.
[Logs]    [2024-02-04T16:28:50.480Z] [bluetooth] DEBUG:__main__:51ff12bb-3ed8-46e5-b4f9-d64e2fec021b: Unknown
[Logs]    [2024-02-04T16:28:50.480Z] [bluetooth] DEBUG:__main__:51ff12bb-3ed8-46e5-b4f9-d64e2fec021c: Unknown
[Logs]    [2024-02-04T16:28:50.737Z] [diagnostics] [2024-02-04 16:28:50 +0000] [10] [INFO] Starting gunicorn 20.1.0
[Logs]    [2024-02-04T16:28:50.748Z] [diagnostics] [2024-02-04 16:28:50 +0000] [10] [INFO] Listening at: http://0.0.0.0:80 (10)
[Logs]    [2024-02-04T16:28:50.750Z] [diagnostics] [2024-02-04 16:28:50 +0000] [10] [INFO] Using worker: sync
[Logs]    [2024-02-04T16:28:50.757Z] [diagnostics] [2024-02-04 16:28:50 +0000] [11] [INFO] Booting worker with pid: 11
[Logs]    [2024-02-04T16:28:52.202Z] Started service 'helium-miner sha256:5d1be2726aac697b6099978d6870619521d9c0faf355ff59c59e6404c86f36ef'
[Logs]    [2024-02-04T16:28:53.207Z] Installing service 'gateway-config sha256:b2f37914b80b34155938286f52d0280295d97964c8e6793abbfb56bf0be9dc2e'
[Logs]    [2024-02-04T16:28:53.228Z] Installing service 'multiplexer sha256:c0874c0bc9012eaa679cffe429db1c3eecf7fbf1aafc8335e41b73e9512f1f1d'
[Logs]    [2024-02-04T16:28:52.592Z] [helium-miner] Keypair has been found. (GW_KEYPAIR = ecc://i2c-1:96?slot=0)
[Logs]    [2024-02-04T16:28:53.014Z] [helium-miner] Onboarding key has been found. (GW_ONBOARDING = ecc://i2c-1:96?slot=0)
[Logs]    [2024-02-04T16:28:53.016Z] [helium-miner] grep: /var/pktfwd/region: No such file or directory
[Logs]    [2024-02-04T16:28:53.867Z] Installed service 'gateway-config sha256:b2f37914b80b34155938286f52d0280295d97964c8e6793abbfb56bf0be9dc2e'
[Logs]    [2024-02-04T16:28:53.870Z] Starting service 'gateway-config sha256:b2f37914b80b34155938286f52d0280295d97964c8e6793abbfb56bf0be9dc2e'
[Logs]    [2024-02-04T16:28:53.879Z] Installed service 'multiplexer sha256:c0874c0bc9012eaa679cffe429db1c3eecf7fbf1aafc8335e41b73e9512f1f1d'
[Logs]    [2024-02-04T16:28:53.880Z] Starting service 'multiplexer sha256:c0874c0bc9012eaa679cffe429db1c3eecf7fbf1aafc8335e41b73e9512f1f1d'
[Logs]    [2024-02-04T16:28:56.059Z] Started service 'gateway-config sha256:b2f37914b80b34155938286f52d0280295d97964c8e6793abbfb56bf0be9dc2e'
[Logs]    [2024-02-04T16:28:56.255Z] Started service 'multiplexer sha256:c0874c0bc9012eaa679cffe429db1c3eecf7fbf1aafc8335e41b73e9512f1f1d'
[Logs]    [2024-02-04T16:28:56.405Z] [multiplexer] Feb 04 16:28:56.404 INFO Starting server: 0.0.0.0:1681
[Logs]    [2024-02-04T16:28:56.405Z] [multiplexer] Feb 04 16:28:56.404 INFO Ready for clients
[Logs]    [2024-02-04T16:28:56.965Z] Installing service 'packet-forwarder sha256:3bcd20c5c4561b571748559af5d8aa1560448e88fa06b1acd09497b88043163b'
[Logs]    [2024-02-04T16:28:59.371Z] Installed service 'packet-forwarder sha256:3bcd20c5c4561b571748559af5d8aa1560448e88fa06b1acd09497b88043163b'
[Logs]    [2024-02-04T16:28:59.373Z] Starting service 'packet-forwarder sha256:3bcd20c5c4561b571748559af5d8aa1560448e88fa06b1acd09497b88043163b'
[Logs]    [2024-02-04T16:29:01.185Z] Started service 'packet-forwarder sha256:3bcd20c5c4561b571748559af5d8aa1560448e88fa06b1acd09497b88043163b'
[Logs]    [2024-02-04T16:29:03.030Z] [helium-miner] Diagnostics container not ready. Going to sleep.
[Logs]    [2024-02-04T16:29:03.927Z] [diagnostics] INFO:root:lets ping hpt to detect network. HPT: 192.168.220.1
[Logs]    [2024-02-04T16:29:05.449Z] [diagnostics] ERROR:root:failed to ping hpt : 192.168.220.1
[Logs]    [2024-02-04T16:29:05.451Z] [diagnostics] ERROR:root:Command '['ping', '-c', '2', '-i', '0.5', '-W', '1', '192.168.220.1']' returned non-zero exit status 1.
[Logs]    [2024-02-04T16:29:05.489Z] [diagnostics] INFO:root:Running DB migrations in '/opt/migrations/migrations' on 'sqlite:////var/data/hm_diag.db'
[Logs]    [2024-02-04T16:29:05.601Z] [diagnostics] INFO:alembic.runtime.migration:Context impl SQLiteImpl.
[Logs]    [2024-02-04T16:29:05.601Z] [diagnostics] INFO:alembic.runtime.migration:Will assume non-transactional DDL.
[Logs]    [2024-02-04T16:29:05.656Z] [diagnostics] INFO:alembic.runtime.migration:Running upgrade  -> 37aeecea6151, Add AuthKV table
[Logs]    [2024-02-04T16:29:05.680Z] [diagnostics] DEBUG:alembic.runtime.migration:new branch insert 37aeecea6151
[Logs]    [2024-02-04T16:29:05.699Z] [diagnostics] INFO:alembic.runtime.migration:Running upgrade 37aeecea6151 -> 81e4b17efa47, Add auth failures table
[Logs]    [2024-02-04T16:29:05.725Z] [diagnostics] DEBUG:alembic.runtime.migration:update 37aeecea6151 to 81e4b17efa47
[Logs]    [2024-02-04T16:29:05.750Z] [diagnostics] DEBUG:tzlocal:/etc/timezone found, contents:
[Logs]    [2024-02-04T16:29:05.750Z] [diagnostics]  Etc/UTC
[Logs]    [2024-02-04T16:29:05.751Z] [diagnostics] 
[Logs]    [2024-02-04T16:29:05.752Z] [diagnostics] DEBUG:tzlocal:/etc/localtime found
[Logs]    [2024-02-04T16:29:05.758Z] [diagnostics] DEBUG:tzlocal:2 found:
[Logs]    [2024-02-04T16:29:05.758Z] [diagnostics]  {'/etc/timezone': 'Etc/UTC', '/etc/localtime is a symlink to': 'Etc/UTC'}
[Logs]    [2024-02-04T16:29:05.767Z] [diagnostics] INFO:apscheduler.scheduler:Scheduler started
[Logs]    [2024-02-04T16:29:05.769Z] [diagnostics] DEBUG:apscheduler.scheduler:Looking for jobs to run
[Logs]    [2024-02-04T16:29:05.770Z] [diagnostics] DEBUG:apscheduler.scheduler:No jobs; waiting until a job is added
[Logs]    [2024-02-04T16:29:01.121Z] [packet-forwarder] FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:29:01.121Z] [packet-forwarder] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:29:01.122Z] [packet-forwarder] All required environment variables have been set.
[Logs]    [2024-02-04T16:29:01.121Z] [packet-forwarder] FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:29:01.121Z] [packet-forwarder] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:29:01.122Z] [packet-forwarder] All required environment variables have been set.
[Logs]    [2024-02-04T16:29:02.194Z] [packet-forwarder] 2024-02-04 16:29:02,192 - [DEBUG] - __main__ - (__main__.py).validate_env -- /opt/pktfwd/__main__.py:(63) - Starting with the following ENV:
[Logs]    [2024-02-04T16:29:02.195Z] [packet-forwarder]         VARIANT=COMP-RAKHM
[Logs]    [2024-02-04T16:29:02.195Z] [packet-forwarder]         REGION_OVERRIDE=False
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         REGION_FILEPATH=/var/pktfwd/region
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         SX1301_REGION_CONFIGS_DIR=/opt/pktfwd/config/lora_templates_sx1301
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         SX1302_REGION_CONFIGS_DIR=/opt/pktfwd/config/lora_templates_sx1302
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         SENTRY_DSN=False
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         BALENA_ID=7d980424c35d76f3f7d928f5a833475f
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         BALENA_APP=davids
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         DIAGNOSTICS_FILEPATH=/var/pktfwd/diagnostics
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         AWAIT_SYSTEM_SLEEP_SECONDS=5
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         RESET_LGW_FILEPATH=/opt/reset_lgw.sh
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         UTIL_CHIP_ID_FILEPATH=/opt/sx1302/chip_id
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         ROOT_DIR=/opt
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         SX1302_LORA_PKT_FWD_FILEPATH=/opt/sx1302/lora_pkt_fwd
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         SX1301_LORA_PKT_FWD_DIR=/opt/sx1301
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder] 
[Logs]    [2024-02-04T16:29:02.199Z] [packet-forwarder] 2024-02-04 16:29:02,193 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).set_variant_attributes -- /opt/pktfwd/pktfwd_app.py:(92) - Variant COMP-RAKHM set with reset_pin 25 and spi_bus spidev0.0
[Logs]    [2024-02-04T16:29:02.200Z] [packet-forwarder] 2024-02-04 16:29:02,194 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).start -- /opt/pktfwd/pktfwd_app.py:(39) - STARTING PKTFWD
[Logs]    [2024-02-04T16:29:02.200Z] [packet-forwarder] 2024-02-04 16:29:02,195 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).await_spi_available -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(409) - SPI bus spidev0.0 Configured Correctly
[Logs]    [2024-02-04T16:29:02.200Z] [packet-forwarder] 2024-02-04 16:29:02,196 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(389) - No region override set (value = False), will retrieve from miner.
[Logs]    [2024-02-04T16:29:02.201Z] [packet-forwarder] 2024-02-04 16:29:02,197 - [WARNING] - hm_pyhelper.miner_param - (api.py).__retry_internal -- /opt/pktfwd-dependencies/retry/api.py:(40) - [Errno 2] No such file or directory: '/var/pktfwd/region', retrying in 60 seconds...
[Logs]    [2024-02-04T16:29:05.842Z] [diagnostics] INFO:apscheduler.scheduler:Added job "ship_diagnostics" to job store "default"
[Logs]    [2024-02-04T16:29:05.843Z] [diagnostics] INFO:apscheduler.scheduler:Added job "quectel_repeating" to job store "default"
[Logs]    [2024-02-04T16:29:05.844Z] [diagnostics] DEBUG:apscheduler.scheduler:Looking for jobs to run
[Logs]    [2024-02-04T16:29:05.845Z] [diagnostics] DEBUG:apscheduler.scheduler:Next wakeup is due at 2024-02-04 17:29:05.842447+00:00 (in 3599.998344 seconds)
[Logs]    [2024-02-04T16:29:05.845Z] [diagnostics] DEBUG:apscheduler.scheduler:Looking for jobs to run
[Logs]    [2024-02-04T16:29:05.845Z] [diagnostics] DEBUG:apscheduler.scheduler:Next wakeup is due at 2024-02-04 17:29:05.842447+00:00 (in 3599.997675 seconds)
[Logs]    [2024-02-04T16:29:05.847Z] [diagnostics] INFO:apscheduler.scheduler:Added job "network_watchdog" to job store "default"
[Logs]    [2024-02-04T16:29:05.848Z] [diagnostics] INFO:apscheduler.scheduler:Added job "emit_heartbeat" to job store "default"
[Logs]    [2024-02-04T16:29:05.849Z] [diagnostics] DEBUG:apscheduler.scheduler:Looking for jobs to run
[Logs]    [2024-02-04T16:29:05.849Z] [diagnostics] INFO:apscheduler.scheduler:Added job "check_nebra_cloud_migration" to job store "default"
[Logs]    [2024-02-04T16:29:05.852Z] [diagnostics] DEBUG:apscheduler.scheduler:Next wakeup is due at 2024-02-04 17:29:05.842447+00:00 (in 3599.993784 seconds)
[Logs]    [2024-02-04T16:29:05.852Z] [diagnostics] INFO:apscheduler.scheduler:Added job "register_third_party_miner" to job store "default"
[Logs]    [2024-02-04T16:29:05.858Z] [diagnostics] DEBUG:apscheduler.scheduler:Looking for jobs to run
[Logs]    [2024-02-04T16:29:05.862Z] [diagnostics] DEBUG:apscheduler.scheduler:Next wakeup is due at 2024-02-04 16:31:05.848815+00:00 (in 119.987696 seconds)
[Logs]    [2024-02-04T16:29:05.863Z] [diagnostics] DEBUG:apscheduler.scheduler:Looking for jobs to run
[Logs]    [2024-02-04T16:29:05.868Z] [diagnostics] DEBUG:apscheduler.scheduler:Next wakeup is due at 2024-02-04 16:31:05.848815+00:00 (in 119.980901 seconds)
[Logs]    [2024-02-04T16:29:05.897Z] [diagnostics] INFO:root:Hostname not set yet...
[Logs]    [2024-02-04T16:29:05.899Z] [diagnostics] 2024-02-04 16:29:05,898 - [INFO] - hw_diag.utilities.balena_supervisor - (balena_supervisor.py).set_hostname -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/balena_supervisor.py:(216) - Setting hostname via Balena supervisor.
[Logs]    [2024-02-04T16:29:05.899Z] [diagnostics] INFO:hw_diag.utilities.balena_supervisor:Setting hostname via Balena supervisor.
[Logs]    [2024-02-04T16:29:05.908Z] [diagnostics] DEBUG:urllib3.connectionpool:Starting new HTTP connection (1): 10.114.104.1:48484
[Logs]    [2024-02-04T16:29:06.526Z] [diagnostics] DEBUG:urllib3.connectionpool:http://10.114.104.1:48484 "PATCH /v1/device/host-config?apikey=d1d24d5a8d4442228542d8776a613e6e HTTP/1.1" 200 2
[Logs]    [2024-02-04T16:29:06.528Z] [diagnostics] 2024-02-04 16:29:06,524 - [INFO] - hw_diag.utilities.balena_supervisor - (balena_supervisor.py)._make_request -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/balena_supervisor.py:(33) - 200
[Logs]    [2024-02-04T16:29:06.528Z] [diagnostics] INFO:hw_diag.utilities.balena_supervisor:200
[Logs]    [2024-02-04T16:29:06.528Z] [diagnostics] 2024-02-04 16:29:06,525 - [INFO] - hw_diag.utilities.balena_supervisor - (balena_supervisor.py)._make_request -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/balena_supervisor.py:(34) - OK
[Logs]    [2024-02-04T16:29:06.529Z] [diagnostics] INFO:hw_diag.utilities.balena_supervisor:OK
[Logs]    [2024-02-04T16:29:41.207Z] Supervisor starting
[Logs]    [2024-02-04T16:29:01.121Z] [packet-forwarder] FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:29:01.121Z] [packet-forwarder] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:29:01.122Z] [packet-forwarder] All required environment variables have been set.
[Logs]    [2024-02-04T16:29:02.194Z] [packet-forwarder] 2024-02-04 16:29:02,192 - [DEBUG] - __main__ - (__main__.py).validate_env -- /opt/pktfwd/__main__.py:(63) - Starting with the following ENV:
[Logs]    [2024-02-04T16:29:02.195Z] [packet-forwarder]         VARIANT=COMP-RAKHM
[Logs]    [2024-02-04T16:29:02.195Z] [packet-forwarder]         REGION_OVERRIDE=False
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         REGION_FILEPATH=/var/pktfwd/region
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         SX1301_REGION_CONFIGS_DIR=/opt/pktfwd/config/lora_templates_sx1301
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         SX1302_REGION_CONFIGS_DIR=/opt/pktfwd/config/lora_templates_sx1302
[Logs]    [2024-02-04T16:29:02.196Z] [packet-forwarder]         SENTRY_DSN=False
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         BALENA_ID=7d980424c35d76f3f7d928f5a833475f
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         BALENA_APP=davids
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         DIAGNOSTICS_FILEPATH=/var/pktfwd/diagnostics
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         AWAIT_SYSTEM_SLEEP_SECONDS=5
[Logs]    [2024-02-04T16:29:02.197Z] [packet-forwarder]         RESET_LGW_FILEPATH=/opt/reset_lgw.sh
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         UTIL_CHIP_ID_FILEPATH=/opt/sx1302/chip_id
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         ROOT_DIR=/opt
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         SX1302_LORA_PKT_FWD_FILEPATH=/opt/sx1302/lora_pkt_fwd
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder]         SX1301_LORA_PKT_FWD_DIR=/opt/sx1301
[Logs]    [2024-02-04T16:29:02.198Z] [packet-forwarder] 
[Logs]    [2024-02-04T16:29:02.199Z] [packet-forwarder] 2024-02-04 16:29:02,193 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).set_variant_attributes -- /opt/pktfwd/pktfwd_app.py:(92) - Variant COMP-RAKHM set with reset_pin 25 and spi_bus spidev0.0
[Logs]    [2024-02-04T16:29:02.200Z] [packet-forwarder] 2024-02-04 16:29:02,194 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).start -- /opt/pktfwd/pktfwd_app.py:(39) - STARTING PKTFWD
[Logs]    [2024-02-04T16:29:02.200Z] [packet-forwarder] 2024-02-04 16:29:02,195 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).await_spi_available -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(409) - SPI bus spidev0.0 Configured Correctly
[Logs]    [2024-02-04T16:29:02.200Z] [packet-forwarder] 2024-02-04 16:29:02,196 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(389) - No region override set (value = False), will retrieve from miner.
[Logs]    [2024-02-04T16:29:02.201Z] [packet-forwarder] 2024-02-04 16:29:02,197 - [WARNING] - hm_pyhelper.miner_param - (api.py).__retry_internal -- /opt/pktfwd-dependencies/retry/api.py:(40) - [Errno 2] No such file or directory: '/var/pktfwd/region', retrying in 60 seconds...
[Logs]    [2024-02-04T16:29:30.399Z] [packet-forwarder] FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:29:30.399Z] [packet-forwarder] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:29:30.399Z] [packet-forwarder] All required environment variables have been set.
[Logs]    [2024-02-04T16:29:31.930Z] [packet-forwarder] 2024-02-04 16:29:31,927 - [DEBUG] - __main__ - (__main__.py).validate_env -- /opt/pktfwd/__main__.py:(63) - Starting with the following ENV:
[Logs]    [2024-02-04T16:29:31.930Z] [packet-forwarder]         VARIANT=COMP-RAKHM
[Logs]    [2024-02-04T16:29:31.931Z] [packet-forwarder]         REGION_OVERRIDE=False
[Logs]    [2024-02-04T16:29:31.931Z] [packet-forwarder]         REGION_FILEPATH=/var/pktfwd/region
[Logs]    [2024-02-04T16:29:31.931Z] [packet-forwarder]         SX1301_REGION_CONFIGS_DIR=/opt/pktfwd/config/lora_templates_sx1301
[Logs]    [2024-02-04T16:29:31.931Z] [packet-forwarder]         SX1302_REGION_CONFIGS_DIR=/opt/pktfwd/config/lora_templates_sx1302
[Logs]    [2024-02-04T16:29:31.931Z] [packet-forwarder]         SENTRY_DSN=False
[Logs]    [2024-02-04T16:29:31.932Z] [packet-forwarder]         BALENA_ID=7d980424c35d76f3f7d928f5a833475f
[Logs]    [2024-02-04T16:29:31.932Z] [packet-forwarder]         BALENA_APP=davids
[Logs]    [2024-02-04T16:29:31.932Z] [packet-forwarder]         DIAGNOSTICS_FILEPATH=/var/pktfwd/diagnostics
[Logs]    [2024-02-04T16:29:31.932Z] [packet-forwarder]         AWAIT_SYSTEM_SLEEP_SECONDS=5
[Logs]    [2024-02-04T16:29:31.932Z] [packet-forwarder]         RESET_LGW_FILEPATH=/opt/reset_lgw.sh
[Logs]    [2024-02-04T16:29:31.933Z] [packet-forwarder]         UTIL_CHIP_ID_FILEPATH=/opt/sx1302/chip_id
[Logs]    [2024-02-04T16:29:31.933Z] [packet-forwarder]         ROOT_DIR=/opt
[Logs]    [2024-02-04T16:29:31.933Z] [packet-forwarder]         SX1302_LORA_PKT_FWD_FILEPATH=/opt/sx1302/lora_pkt_fwd
[Logs]    [2024-02-04T16:29:31.933Z] [packet-forwarder]         SX1301_LORA_PKT_FWD_DIR=/opt/sx1301
[Logs]    [2024-02-04T16:29:31.933Z] [packet-forwarder] 
[Logs]    [2024-02-04T16:29:31.934Z] [packet-forwarder] 2024-02-04 16:29:31,928 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).set_variant_attributes -- /opt/pktfwd/pktfwd_app.py:(92) - Variant COMP-RAKHM set with reset_pin 25 and spi_bus spidev0.0
[Logs]    [2024-02-04T16:29:31.934Z] [packet-forwarder] 2024-02-04 16:29:31,928 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).start -- /opt/pktfwd/pktfwd_app.py:(39) - STARTING PKTFWD
[Logs]    [2024-02-04T16:29:31.947Z] [packet-forwarder] 2024-02-04 16:29:31,946 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).await_spi_available -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(409) - SPI bus spidev0.0 Configured Correctly
[Logs]    [2024-02-04T16:29:31.948Z] [packet-forwarder] 2024-02-04 16:29:31,946 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(389) - No region override set (value = False), will retrieve from miner.
[Logs]    [2024-02-04T16:29:31.950Z] [packet-forwarder] 2024-02-04 16:29:31,948 - [WARNING] - hm_pyhelper.miner_param - (api.py).__retry_internal -- /opt/pktfwd-dependencies/retry/api.py:(40) - [Errno 2] No such file or directory: '/var/pktfwd/region', retrying in 60 seconds...
[Logs]    [2024-02-04T16:29:46.882Z] Warning: Suppressed 257 message(s) due to slow reading
[Logs]    [2024-02-04T16:29:08.286Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:08.055846501+00:00"}"
[Logs]    [2024-02-04T16:29:08.286Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:08.388Z] [diagnostics] 2024-02-04 16:29:08,387 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:08.389Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:08.390Z] [diagnostics] 2024-02-04 16:29:08,387 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:08.390Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:08.391Z] [diagnostics] 2024-02-04 16:29:08,389 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(106) - Retrieving list of BLE device(s)
[Logs]    [2024-02-04T16:29:08.392Z] [diagnostics] INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s)
[Logs]    [2024-02-04T16:29:08.401Z] [diagnostics] 2024-02-04 16:29:08,399 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(129) - Found the following BLE Devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:29:08.401Z] [diagnostics] INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:29:08.401Z] [diagnostics] 2024-02-04 16:29:08,399 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(175) - Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:29:08.402Z] [diagnostics] INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:29:08.408Z] [diagnostics] 2024-02-04 16:29:08,407 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(202) - Found the following LTE Devices: []
[Logs]    [2024-02-04T16:29:08.409Z] [diagnostics] INFO:hw_diag.utilities.hardware:Found the following LTE Devices: []
[Logs]    [2024-02-04T16:29:08.410Z] [diagnostics] INFO:root:Diagnostics shipping not requested, skipping.
[Logs]    [2024-02-04T16:29:08.411Z] [diagnostics] INFO:root:Diagnostics complete
[Logs]    [2024-02-04T16:29:10.233Z] [diagnostics] INFO:root:Running periodic hardware diagnostics
[Logs]    [2024-02-04T16:29:10.445Z] [diagnostics] 2024-02-04 16:29:10,443 - [ERROR] - hm_pyhelper.miner_param - (gateway_diagnostics.py).call_grpc -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/gateway_diagnostics.py:(42) - rpc error: <_InactiveRpcError of RPC that terminated with:
[Logs]    [2024-02-04T16:29:10.447Z] [diagnostics]  status = StatusCode.UNAVAILABLE
[Logs]    [2024-02-04T16:29:10.449Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:10.449Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:10.238417625+00:00"}"
[Logs]    [2024-02-04T16:29:10.449Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:10.450Z] [diagnostics] ERROR:hm_pyhelper.miner_param:rpc error: <_InactiveRpcError of RPC that terminated with:
[Logs]    [2024-02-04T16:29:10.450Z] [diagnostics]  status = StatusCode.UNAVAILABLE
[Logs]    [2024-02-04T16:29:10.451Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:10.451Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:10.238417625+00:00"}"
[Logs]    [2024-02-04T16:29:10.451Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:10.452Z] [diagnostics] 2024-02-04 16:29:10,443 - [ERROR] - hm_pyhelper.miner_param - (gateway_diagnostics.py).call_grpc -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/gateway_diagnostics.py:(43) - <_InactiveRpcError of RPC that terminated with:
[Logs]    [2024-02-04T16:29:10.452Z] [diagnostics]  status = StatusCode.UNAVAILABLE
[Logs]    [2024-02-04T16:29:10.452Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:10.453Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:10.238417625+00:00"}"
[Logs]    [2024-02-04T16:29:10.453Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:10.454Z] [diagnostics] Traceback (most recent call last):
[Logs]    [2024-02-04T16:29:10.454Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/gateway_diagnostics.py", line 40, in call_grpc
[Logs]    [2024-02-04T16:29:10.454Z] [diagnostics]     return getattr(client, method_name)(*args, **kwargs)
[Logs]    [2024-02-04T16:29:10.454Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:28:44.591Z] [dbus-session] balenaBlocks dbus version: 0.0.2
[Logs]    [2024-02-04T16:28:44.601Z] [dbus-session] unix:path=/session/dbus/session_bus_socket,guid=86ad8fe8753897c3845639e265bfbb3c
[Logs]    [2024-02-04T16:29:31.785Z] [dbus-session] balenaBlocks dbus version: 0.0.2
[Logs]    [2024-02-04T16:29:31.793Z] [dbus-session] unix:path=/session/dbus/session_bus_socket,guid=58d8f33ef1105bc0c461d65865bfbb6b
[Logs]    [2024-02-04T16:29:10.455Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/gateway_grpc/client.py", line 75, in get_pubkey
[Logs]    [2024-02-04T16:29:10.455Z] [diagnostics]     encoded_key = self.stub.pubkey(local_pb2.pubkey_req()).address
[Logs]    [2024-02-04T16:29:10.455Z] [diagnostics]                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:10.456Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/grpc/_channel.py", line 1030, in __call__
[Logs]    [2024-02-04T16:29:10.456Z] [diagnostics]     return _end_unary_response_blocking(state, call, False, None)
[Logs]    [2024-02-04T16:29:10.457Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:10.457Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/grpc/_channel.py", line 910, in _end_unary_response_blocking
[Logs]    [2024-02-04T16:29:10.457Z] [diagnostics]     raise _InactiveRpcError(state)  # pytype: disable=not-instantiable
[Logs]    [2024-02-04T16:29:10.457Z] [diagnostics]     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:10.457Z] [diagnostics] grpc._channel._InactiveRpcError: <_InactiveRpcError of RPC that terminated with:
[Logs]    [2024-02-04T16:29:10.457Z] [diagnostics]  status = StatusCode.UNAVAILABLE
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:10.238417625+00:00"}"
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics] ERROR:hm_pyhelper.miner_param:<_InactiveRpcError of RPC that terminated with:
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics]  status = StatusCode.UNAVAILABLE
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.5:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:10.238417625+00:00"}"
[Logs]    [2024-02-04T16:29:10.458Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics] Traceback (most recent call last):
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/gateway_diagnostics.py", line 40, in call_grpc
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics]     return getattr(client, method_name)(*args, **kwargs)
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/gateway_grpc/client.py", line 75, in get_pubkey
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics]     encoded_key = self.stub.pubkey(local_pb2.pubkey_req()).address
[Logs]    [2024-02-04T16:29:10.459Z] [diagnostics]                   ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:10.460Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/grpc/_channel.py", line 1030, in __call__
[Logs]    [2024-02-04T16:29:10.460Z] [diagnostics]     return _end_unary_response_blocking(state, call, False, None)
[Logs]    [2024-02-04T16:29:10.460Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:10.460Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/grpc/_channel.py", line 910, in _end_unary_response_blocking
[Logs]    [2024-02-04T16:29:10.460Z] [diagnostics]     raise _InactiveRpcError(state)  # pytype: disable=not-instantiable
[Logs]    [2024-02-04T16:29:46.886Z] Warning: Suppressed 229 message(s) due to slow reading
Agent registered
[CHG] Controller E4:5F:01:37:0D:E1 Pairable: yes
[Logs]    [2024-02-04T16:29:08.669Z] [gateway-config] [bluetooth]# pairable off
[Logs]    [2024-02-04T16:29:08.669Z] [gateway-config] [bluetooth]# quit
FREQ variable is already set as N/A (Non Nebra Miner).
[Logs]    [2024-02-04T16:29:08.766Z] [gateway-config] VARIANT variable is already set as COMP-RAKHM.
[Logs]    [2024-02-04T16:29:08.766Z] [gateway-config] All required environment variables have been set.
[Logs]    [2024-02-04T16:29:08.778Z] [gateway-config] method return time=1707064148.777671 sender=org.freedesktop.DBus -> destination=:1.0 serial=3 reply_serial=2
[Logs]    [2024-02-04T16:29:08.778Z] [gateway-config]    array [
[Logs]    [2024-02-04T16:29:08.778Z] [gateway-config]       string "org.freedesktop.DBus"
[Logs]    [2024-02-04T16:29:08.779Z] [gateway-config]       string ":1.0"
[Logs]    [2024-02-04T16:29:08.779Z] [gateway-config]    ]
[Logs]    [2024-02-04T16:29:08.781Z] [gateway-config] DBus is now accepting connections
[Logs]    [2024-02-04T16:29:10.023Z] [gateway-config] libmraa[14]: libmraa version v2.1.0-24-gbd91964 initialised by user 'root' with EUID 0
[Logs]    [2024-02-04T16:29:10.024Z] [gateway-config] libmraa[14]: gpio: platform doesn't support chardev, falling back to sysfs
[Logs]    [2024-02-04T16:29:10.025Z] [gateway-config] libmraa[14]: libmraa initialised for platform 'Raspberry Pi Model B Rev 1' of type 5
[Logs]    [2024-02-04T16:29:10.033Z] [gateway-config] 2024-02-04 16:29:10,032 - [DEBUG] - __main__ - (__main__.py).validate_env -- /opt/venv/lib/python3.9/site-packages/gatewayconfig/__main__.py:(34) - Starting with the following ENV:
[Logs]    [2024-02-04T16:29:10.033Z] [gateway-config]         SENTRY_DSN=None
[Logs]    [2024-02-04T16:29:10.034Z] [gateway-config]         BALENA_APP_NAME=davids
[Logs]    [2024-02-04T16:29:10.034Z] [gateway-config]         BALENA_DEVICE_UUID=7d980424c35d76f3f7d928f5a833475f
[Logs]    [2024-02-04T16:29:10.034Z] [gateway-config]         VARIANT=COMP-RAKHM
[Logs]    [2024-02-04T16:29:10.034Z] [gateway-config]         ETH0_MAC_ADDRESS_FILEPATH=/sys/class/net/eth0/address
[Logs]    [2024-02-04T16:29:10.034Z] [gateway-config]         WLAN0_MAC_ADDRESS_FILEPATH=/sys/class/net/wlan0/address
[Logs]    [2024-02-04T16:29:10.034Z] [gateway-config]         DIAGNOSTICS_JSON_URL=http://diagnostics/json
[Logs]    [2024-02-04T16:29:10.035Z] [gateway-config]         ETHERNET_IS_ONLINE_FILEPATH=/sys/class/net/eth0/carrier
[Logs]    [2024-02-04T16:29:10.035Z] [gateway-config]         FIRMWARE_VERSION=v1.3.0
[Logs]    [2024-02-04T16:29:10.035Z] [gateway-config] 
[Logs]    [2024-02-04T16:29:10.051Z] [gateway-config] 2024-02-04 16:29:10,044 - [DEBUG] - gatewayconfig.gatewayconfig_app - (gatewayconfig_app.py).__init__ -- /opt/venv/lib/python3.9/site-packages/gatewayconfig/gatewayconfig_app.py:(50) - Read eth0 mac address E4:5F:01:37:0D:DF and wlan0 E4:5F:01:37:0D:E0
[Logs]    [2024-02-04T16:29:10.156Z] [gateway-config] 2024-02-04 16:29:10,154 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/venv/lib/python3.9/site-packages/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:10.156Z] [gateway-config] 2024-02-04 16:29:10,155 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/venv/lib/python3.9/site-packages/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:10.167Z] [gateway-config] 2024-02-04 16:29:10,166 - [DEBUG] - gatewayconfig.bluetooth.characteristics.diagnostics_characteristic - (diagnostics_characteristic.py).new_diagnostics_proto -- /opt/venv/lib/python3.9/site-packages/gatewayconfig/bluetooth/characteristics/diagnostics_characteristic.py:(52) - New Diagnostics Proto
[Logs]    [2024-02-04T16:29:42.067Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.6:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:42.068Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.6:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:42.051380443+00:00"}"
[Logs]    [2024-02-04T16:29:42.068Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:42.068Z] [diagnostics] Traceback (most recent call last):
[Logs]    [2024-02-04T16:29:42.068Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/gateway_diagnostics.py", line 40, in call_grpc
[Logs]    [2024-02-04T16:29:42.068Z] [diagnostics]     return getattr(client, method_name)(*args, **kwargs)
[Logs]    [2024-02-04T16:29:42.068Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:42.069Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/gateway_grpc/client.py", line 68, in get_region
[Logs]    [2024-02-04T16:29:42.069Z] [diagnostics]     region_id = self.get_region_enum()
[Logs]    [2024-02-04T16:29:42.069Z] [diagnostics]                 ^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:42.069Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/gateway_grpc/client.py", line 61, in get_region_enum
[Logs]    [2024-02-04T16:29:42.069Z] [diagnostics]     return self.stub.region(local_pb2.region_req()).region
[Logs]    [2024-02-04T16:29:42.070Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:42.070Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/grpc/_channel.py", line 1030, in __call__
[Logs]    [2024-02-04T16:29:42.070Z] [diagnostics]     return _end_unary_response_blocking(state, call, False, None)
[Logs]    [2024-02-04T16:29:42.070Z] [diagnostics]            ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:42.070Z] [diagnostics]   File "/opt/python-dependencies/lib/python3.11/site-packages/grpc/_channel.py", line 910, in _end_unary_response_blocking
[Logs]    [2024-02-04T16:29:42.070Z] [diagnostics]     raise _InactiveRpcError(state)  # pytype: disable=not-instantiable
[Logs]    [2024-02-04T16:29:42.071Z] [diagnostics]     ^^^^^^^^^^^^^^^^^^^^^^^^^^^^^^
[Logs]    [2024-02-04T16:29:42.071Z] [diagnostics] grpc._channel._InactiveRpcError: <_InactiveRpcError of RPC that terminated with:
[Logs]    [2024-02-04T16:29:42.071Z] [diagnostics]  status = StatusCode.UNAVAILABLE
[Logs]    [2024-02-04T16:29:42.071Z] [diagnostics]  details = "failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.6:4467: Failed to connect to remote host: Connection refused"
[Logs]    [2024-02-04T16:29:42.071Z] [diagnostics]  debug_error_string = "UNKNOWN:failed to connect to all addresses; last error: UNKNOWN: ipv4:172.17.0.6:4467: Failed to connect to remote host: Connection refused {grpc_status:14, created_time:"2024-02-04T16:29:42.051380443+00:00"}"
[Logs]    [2024-02-04T16:29:42.072Z] [diagnostics] >
[Logs]    [2024-02-04T16:29:42.187Z] [diagnostics] 2024-02-04 16:29:42,186 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:42.187Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:42.188Z] [diagnostics] 2024-02-04 16:29:42,186 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:42.188Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:42.190Z] [diagnostics] 2024-02-04 16:29:42,189 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(106) - Retrieving list of BLE device(s)
[Logs]    [2024-02-04T16:29:42.190Z] [diagnostics] INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s)
[Logs]    [2024-02-04T16:29:42.203Z] [diagnostics] 2024-02-04 16:29:42,202 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(129) - Found the following BLE Devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:29:42.203Z] [diagnostics] INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:29:42.204Z] [diagnostics] 2024-02-04 16:29:42,203 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(175) - Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:29:42.204Z] [diagnostics] INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:29:42.212Z] [diagnostics] 2024-02-04 16:29:42,211 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(202) - Found the following LTE Devices: []
[Logs]    [2024-02-04T16:29:42.214Z] [diagnostics] INFO:hw_diag.utilities.hardware:Found the following LTE Devices: []
[Logs]    [2024-02-04T16:29:42.215Z] [diagnostics] INFO:root:Diagnostics shipping not requested, skipping.
[Logs]    [2024-02-04T16:29:42.215Z] [diagnostics] INFO:root:Diagnostics complete
[Logs]    [2024-02-04T16:29:42.758Z] [diagnostics] 2024-02-04 16:29:42,756 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n  "result": "pass",\n  "tests": {\n    "ecdh(0)": {\n      "checks": "ok",\n      "result": "pass"\n    },\n    "key_config(0)": {\n      "checks": {\n        "auth_key": "0",\n        "intrusion_disable": "false",\n        "key_type": "ecc",\n        "lockable": "true",\n        "private": "true",\n        "pub_info": "true",\n        "req_auth": "false",\n        "req_random": "false",\n        "x509_index": "0"\n      },\n      "result": "pass"\n    },\n    "miner_key(0)": {\n      "checks": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n      "result": "pass"\n    },\n    "sign(0)": {\n      "checks": "ok",\n      "result": "pass"\n    },\n    "slot_config(0)": {\n      "checks": {\n        "ecdh_operation": "true",\n        "encrypt_read": "false",\n        "external_signatures": "true",\n        "internal_signatures": "true",\n        "limited_use": "false",\n        "secret": "true"\n      },\n      "result": "pass"\n    },\n    "zone_locked(config)": {\n      "checks": "ok",\n      "result": "pass"\n    },\n    "zone_locked(data)": {\n      "checks": "ok",\n      "result": "pass"\n    }\n  }\n}\n'
[Logs]    [2024-02-04T16:29:42.758Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n  "result": "pass",\n  "tests": {\n    "ecdh(0)": {\n      "checks": "ok",\n      "result": "pass"\n    },\n    "key_config(0)": {\n      "checks": {\n        "auth_key": "0",\n        "intrusion_disable": "false",\n        "key_type": "ecc",\n        "lockable": "true",\n        "private": "true",\n        "pub_info": "true",\n        "req_auth": "false",\n        "req_random": "false",\n        "x509_index": "0"\n      },\n      "result": "pass"\n    },\n    "miner_key(0)": {\n      "checks": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n      "result": "pass"\n    },\n    "sign(0)": {\n      "checks": "ok",\n      "result": "pass"\n    },\n    "slot_config(0)": {\n      "checks": {\n        "ecdh_operation": "true",\n        "encrypt_read": "false",\n        "external_signatures": "true",\n        "internal_signatures": "true",\n        "limited_use": "false",\n        "secret": "true"\n      },\n      "result": "pass"\n    },\n    "zone_locked(config)": {\n      "checks": "ok",\n      "result": "pass"\n    },\n    "zone_locked(data)": {\n      "checks": "ok",\n      "result": "pass"\n    }\n  }\n}\n'
[Logs]    [2024-02-04T16:29:42.759Z] [diagnostics] 2024-02-04 16:29:42,757 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:42.759Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:29:42.760Z] [diagnostics] 2024-02-04 16:29:42,758 - [DEBUG] - hw_diag.diagnostics.bt_diagnostic - (bt_diagnostic.py).perform_test -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/bt_diagnostic.py:(28) - Retrieving list of Bluetooth device(s)
[Logs]    [2024-02-04T16:29:42.760Z] [diagnostics] DEBUG:hw_diag.diagnostics.bt_diagnostic:Retrieving list of Bluetooth device(s)
[Logs]    [2024-02-04T16:29:42.770Z] [diagnostics] 2024-02-04 16:29:42,768 - [INFO] - hw_diag.diagnostics.bt_diagnostic - (bt_diagnostic.py).perform_test -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/bt_diagnostic.py:(32) - Found the following Bluetooth devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:29:42.771Z] [diagnostics] INFO:hw_diag.diagnostics.bt_diagnostic:Found the following Bluetooth devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:29:42.775Z] [diagnostics] 2024-02-04 16:29:42,769 - [INFO] - hw_diag.diagnostics.lte_diagnostic - (lte_diagnostic.py).perform_test -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/lte_diagnostic.py:(32) - Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:29:42.775Z] [diagnostics] INFO:hw_diag.diagnostics.lte_diagnostic:Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:29:42.783Z] [diagnostics] 2024-02-04 16:29:42,782 - [INFO] - hw_diag.diagnostics.lte_diagnostic - (lte_diagnostic.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/lte_diagnostic.py:(63) - Found the following LTE Devices: []
[Logs]    [2024-02-04T16:29:42.784Z] [diagnostics] INFO:hw_diag.diagnostics.lte_diagnostic:Found the following LTE Devices: []
[Logs]    [2024-02-04T16:29:42.784Z] [diagnostics] 2024-02-04 16:29:42,783 - [INFO] - hw_diag.diagnostics.lte_diagnostic - (lte_diagnostic.py).perform_test -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/diagnostics/lte_diagnostic.py:(36) - Found the following LTE devices: []
[Logs]    [2024-02-04T16:29:42.785Z] [diagnostics] INFO:hw_diag.diagnostics.lte_diagnostic:Found the following LTE devices: []
[Logs]    [2024-02-04T16:29:42.876Z] [diagnostics] 2024-02-04 16:29:42,873 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:42.876Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:29:47.385Z] Warning: Suppressed 186 message(s) due to slow reading
[Logs]    [2024-02-04T16:29:46.698Z] [helium-miner] Keypair has been found. (GW_KEYPAIR = ecc://i2c-1:96?slot=0)
[Logs]    [2024-02-04T16:29:46.979Z] [helium-miner] Onboarding key has been found. (GW_ONBOARDING = ecc://i2c-1:96?slot=0)
[Logs]    [2024-02-04T16:29:46.981Z] [helium-miner] grep: /var/pktfwd/region: No such file or directory
[Logs]    [2024-02-04T16:29:46.997Z] [helium-miner] Starting gateway-rs...
[Logs]    [2024-02-04T16:29:46.998Z] [helium-miner] crond[15]: crond (busybox 1.35.0) started, log level 8
[Logs]    [2024-02-04T16:29:47.169Z] [helium-miner] 2024-02-04T16:29:47.169023Z  INFO run: gateway_rs::server: starting server version=1.3.0 key=112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ
[Logs]    [2024-02-04T16:29:47.170Z] [helium-miner] 2024-02-04T16:29:47.169113Z  INFO run: gateway_rs::region_watcher: starting default_region=UNKNOWN
[Logs]    [2024-02-04T16:29:47.170Z] [helium-miner] 2024-02-04T16:29:47.169211Z  INFO run: gateway_rs::beaconer: starting beacon_interval=21600 disabled=false uri=http://mainnet-pociot.helium.io:9080/
[Logs]    [2024-02-04T16:29:47.170Z] [helium-miner] 2024-02-04T16:29:47.169267Z  INFO run: gateway_rs::gateway: starting listen="0.0.0.0:1680"
[Logs]    [2024-02-04T16:29:47.171Z] [helium-miner] 2024-02-04T16:29:47.169314Z  INFO run:run: gateway_rs::packet_router: starting uri=http://mainnet-router.helium.io:8080/
[Logs]    [2024-02-04T16:29:47.172Z] [helium-miner] 2024-02-04T16:29:47.169351Z  INFO run: gateway_rs::api::server: starting listen=0.0.0.0:4467
[Logs]    [2024-02-04T16:29:52.271Z] [helium-miner] 2024-02-04T16:29:52.269564Z  INFO run: gateway_rs::service::conduit: initialized session module="beaconer" session_key=13iuUANnCbyCSw6Fn4skSHn2RjYpkutEzBTqUfXUc1KjaWFwdqj
[Logs]    [2024-02-04T16:29:52.497Z] [helium-miner] 2024-02-04T16:29:52.495308Z  INFO run:run: gateway_rs::service::conduit: initialized session module="packet_router" session_key=132dhD28gFH7EMb5N1a3HgSpMA9Pd9pet8NvX7ttBRCWjYzXYkk
[Logs]    [2024-02-04T16:29:55.770Z] Service exited 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:29:55.879Z] Killed service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:29:57.419Z] Installing service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:29:57.635Z] Installed service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:29:57.638Z] Starting service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:29:58.622Z] Started service 'bluetooth sha256:c0952ef242f44737e7cb0fe6a70f8a8fdffc2b128c639cb1f9cbffa7bb4f7623'
[Logs]    [2024-02-04T16:29:58.581Z] [bluetooth] Starting bluetooth container...
[Logs]    [2024-02-04T16:29:58.601Z] [bluetooth] method return time=1707064198.600420 sender=:1.0 -> destination=:1.133 serial=2180 reply_serial=2
[Logs]    [2024-02-04T16:29:58.601Z] [bluetooth]    object path "/org/freedesktop/systemd1/job/3925"
[Logs]    [2024-02-04T16:29:58.688Z] [bluetooth] Starting system message bus: dbus.
[Logs]    [2024-02-04T16:29:58.581Z] [bluetooth] Starting bluetooth container...
[Logs]    [2024-02-04T16:29:58.601Z] [bluetooth] method return time=1707064198.600420 sender=:1.0 -> destination=:1.133 serial=2180 reply_serial=2
[Logs]    [2024-02-04T16:29:58.601Z] [bluetooth]    object path "/org/freedesktop/systemd1/job/3925"
[Logs]    [2024-02-04T16:29:58.688Z] [bluetooth] Starting system message bus: dbus.
[Logs]    [2024-02-04T16:29:59.504Z] [bluetooth] Bluetooth agent started!
[Logs]    [2024-02-04T16:30:00.844Z] [helium-miner] 2024-02-04T16:30:00.843126Z  INFO run: gateway_rs::region_watcher: fetched config region_params pubkey=137oJzq1qZpSbzHawaysTGGsRCYTXG1MiTMQNxYSsQJp4YMDdN8 uri=http://mainnet-config.helium.io:6080/ default_region=UNKNOWN region=EU868
[Logs]    [2024-02-04T16:30:00.844Z] [helium-miner] 2024-02-04T16:30:00.843303Z  INFO run: gateway_rs::beaconer: next beacon time beacon_time=2024-02-04 17:43:13.0 +00:00:00
[Logs]    [2024-02-04T16:30:00.844Z] [helium-miner] 2024-02-04T16:30:00.843328Z  INFO run: gateway_rs::beaconer: region updated region="EU868"
[Logs]    [2024-02-04T16:30:00.845Z] [helium-miner] 2024-02-04T16:30:00.843363Z  INFO run: gateway_rs::gateway: region updated region="EU868"
[Logs]    [2024-02-04T16:30:01.003Z] [helium-miner] crond[15]: USER root pid  25 cmd run-parts /etc/periodic/15min
[Logs]    [2024-02-04T16:30:01.055Z] [bluetooth] Starting ble service... 
[Logs]    [2024-02-04T16:30:01.062Z] [bluetooth] DEBUG:asyncio:Using selector: EpollSelector
[Logs]    [2024-02-04T16:30:01.087Z] [bluetooth] DEBUG:__main__:Service added with uuid a07498ca-ad5b-474e-940d-16f1fbe7e8cd and name SrcFul Energy Gateway 370ddf.
[Logs]    [2024-02-04T16:30:01.091Z] [bluetooth] DEBUG:__main__:51ff12bb-3ed8-46e5-b4f9-d64e2fec021b: Unknown
[Logs]    [2024-02-04T16:30:01.091Z] [bluetooth] DEBUG:__main__:51ff12bb-3ed8-46e5-b4f9-d64e2fec021c: Unknown
[Logs]    [2024-02-04T16:30:18.245Z] [helium-miner] Region file data (None) doesn't match gateway-rs (EU868). Updating region file...
[Logs]    [2024-02-04T16:30:31.951Z] [packet-forwarder] 2024-02-04 16:30:31,950 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(389) - No region override set (value = False), will retrieve from miner.
[Logs]    [2024-02-04T16:30:31.952Z] [packet-forwarder] 2024-02-04 16:30:31,951 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(393) - Region EU868 parsed from /var/pktfwd/region
[Logs]    [2024-02-04T16:30:31.953Z] [packet-forwarder] 2024-02-04 16:30:31,952 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).prepare_to_start -- /opt/pktfwd/pktfwd_app.py:(74) - Region set to EU868
[Logs]    [2024-02-04T16:30:31.954Z] [packet-forwarder] 2024-02-04 16:30:31,952 - [DEBUG] - pktfwd.utils - (utils.py).await_system_ready -- /opt/pktfwd/utils.py:(60) - Waiting 5 seconds for systems to be ready
[Logs]    [2024-02-04T16:30:36.954Z] [packet-forwarder] 2024-02-04 16:30:36,953 - [DEBUG] - pktfwd.utils - (utils.py).await_system_ready -- /opt/pktfwd/utils.py:(62) - System now ready
[Logs]    [2024-02-04T16:30:36.956Z] [packet-forwarder] 2024-02-04 16:30:36,953 - [DEBUG] - pktfwd.pktfwd_app - (pktfwd_app.py).prepare_to_start -- /opt/pktfwd/pktfwd_app.py:(77) - Finished preparing pktfwd
[Logs]    [2024-02-04T16:30:39.094Z] [packet-forwarder] 2024-02-04 16:30:39,093 - [DEBUG] - pktfwd.utils - (utils.py).is_concentrator_sx1302 -- /opt/pktfwd/utils.py:(83) - SX1302 / SX1303 detected.                      util_chip_id script exited without error.
[Logs]    [2024-02-04T16:30:39.097Z] [packet-forwarder] 2024-02-04 16:30:39,095 - [DEBUG] - pktfwd.utils - (utils.py).replace_sx1302_global_conf_with_regional -- /opt/pktfwd/utils.py:(198) - Injecting SPI bus spidev0.0 into global conf
[Logs]    [2024-02-04T16:30:39.097Z] [packet-forwarder] 2024-02-04 16:30:39,096 - [DEBUG] - pktfwd.utils - (utils.py).replace_sx1302_global_conf_with_regional -- /opt/pktfwd/utils.py:(204) - Saving SX1302 global conf from /opt/pktfwd/config/lora_templates_sx1302/global_conf.json.EU868 to /opt/global_conf.json with spi bus spidev0.0
[Logs]    [2024-02-04T16:30:39.102Z] [packet-forwarder] 2024-02-04 16:30:39,101 - [DEBUG] - pktfwd.utils - (utils.py).replace_sx1302_global_conf_with_regional -- /opt/pktfwd/utils.py:(210) - Copying SX1302 local conf from /opt/pktfwd/config/lora_templates_sx1302/local_conf.json to /opt/local_conf.json
[Logs]    [2024-02-04T16:30:39.114Z] [packet-forwarder] 2024-02-04 16:30:39,114 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(389) - No region override set (value = None), will retrieve from miner.
[Logs]    [2024-02-04T16:30:39.115Z] [packet-forwarder] 2024-02-04 16:30:39,114 - [DEBUG] - hm_pyhelper.miner_param - (miner_param.py).retry_get_region -- /opt/pktfwd-dependencies/hm_pyhelper/miner_param.py:(393) - Region EU868 parsed from /var/pktfwd/region
[Logs]    [2024-02-04T16:30:39.115Z] [packet-forwarder] 2024-02-04 16:30:39,115 - [DEBUG] - pktfwd.utils - (utils.py).retry_start_concentrator -- /opt/pktfwd/utils.py:(238) - Region before starting concentrator EU868
[Logs]    [2024-02-04T16:30:39.121Z] [packet-forwarder] *** Packet Forwarder ***
[Logs]    [2024-02-04T16:30:39.121Z] [packet-forwarder] Version: 2.1.0
[Logs]    [2024-02-04T16:30:39.121Z] [packet-forwarder] *** SX1302 HAL library version info ***
[Logs]    [2024-02-04T16:30:39.122Z] [packet-forwarder] Version: 2.1.0;
[Logs]    [2024-02-04T16:30:39.122Z] [packet-forwarder] ***
[Logs]    [2024-02-04T16:30:39.122Z] [packet-forwarder] INFO: Little endian host
[Logs]    [2024-02-04T16:30:39.123Z] [packet-forwarder] INFO: found configuration file global_conf.json, parsing it
[Logs]    [2024-02-04T16:30:39.123Z] [packet-forwarder] INFO: global_conf.json does contain a JSON object named SX130x_conf, parsing SX1302 parameters
[Logs]    [2024-02-04T16:30:39.123Z] [packet-forwarder] INFO: com_type SPI, com_path /dev/spidev0.0, lorawan_public 1, clksrc 0, full_duplex 0
[Logs]    [2024-02-04T16:30:39.123Z] [packet-forwarder] INFO: antenna_gain 0 dBi
[Logs]    [2024-02-04T16:30:39.124Z] [packet-forwarder] INFO: Configuring legacy timestamp
[Logs]    [2024-02-04T16:30:39.124Z] [packet-forwarder] INFO: no configuration for SX1261
[Logs]    [2024-02-04T16:30:39.124Z] [packet-forwarder] INFO: Configuring Tx Gain LUT for rf_chain 0 with 16 indexes for sx1250
[Logs]    [2024-02-04T16:30:39.124Z] [packet-forwarder] INFO: radio 0 enabled (type SX1250), center frequency 867500000, RSSI offset -215.399994, tx enabled 1, single input mode 0
[Logs]    [2024-02-04T16:30:39.125Z] [packet-forwarder] INFO: radio 1 enabled (type SX1250), center frequency 868500000, RSSI offset -215.399994, tx enabled 0, single input mode 0
[Logs]    [2024-02-04T16:30:39.125Z] [packet-forwarder] INFO: no configuration for LoRa multi-SF spreading factors enabling
[Logs]    [2024-02-04T16:30:39.125Z] [packet-forwarder] INFO: Lora multi-SF channel 0>  radio 1, IF -400000 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.126Z] [packet-forwarder] INFO: Lora multi-SF channel 1>  radio 1, IF -200000 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.126Z] [packet-forwarder] INFO: Lora multi-SF channel 2>  radio 1, IF 0 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.126Z] [packet-forwarder] INFO: Lora multi-SF channel 3>  radio 0, IF -400000 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.127Z] [packet-forwarder] INFO: Lora multi-SF channel 4>  radio 0, IF -200000 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.127Z] [packet-forwarder] INFO: Lora multi-SF channel 5>  radio 0, IF 0 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.127Z] [packet-forwarder] INFO: Lora multi-SF channel 6>  radio 0, IF 200000 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.128Z] [packet-forwarder] INFO: Lora multi-SF channel 7>  radio 0, IF 400000 Hz, 125 kHz bw, SF 5 to 12
[Logs]    [2024-02-04T16:30:39.129Z] [packet-forwarder] INFO: Lora std channel> radio 1, IF -200000 Hz, 250000 Hz bw, SF 7, Explicit header
[Logs]    [2024-02-04T16:30:39.129Z] [packet-forwarder] INFO: FSK channel 8 disabled
[Logs]    [2024-02-04T16:30:39.129Z] [packet-forwarder] INFO: global_conf.json does contain a JSON object named gateway_conf, parsing gateway parameters
[Logs]    [2024-02-04T16:30:39.129Z] [packet-forwarder] INFO: gateway MAC address is configured to 0000000000000000
[Logs]    [2024-02-04T16:30:39.130Z] [packet-forwarder] INFO: server hostname or IP address is configured to "multiplexer"
[Logs]    [2024-02-04T16:30:39.130Z] [packet-forwarder] INFO: upstream port is configured to "1681"
[Logs]    [2024-02-04T16:30:39.130Z] [packet-forwarder] INFO: downstream port is configured to "1681"
[Logs]    [2024-02-04T16:30:39.130Z] [packet-forwarder] INFO: downstream keep-alive interval is configured to 10 seconds
[Logs]    [2024-02-04T16:30:39.130Z] [packet-forwarder] INFO: statistics display interval is configured to 30 seconds
[Logs]    [2024-02-04T16:30:39.130Z] [packet-forwarder] INFO: upstream PUSH_DATA time-out is configured to 100 ms
[Logs]    [2024-02-04T16:30:39.131Z] [packet-forwarder] INFO: packets received with a valid CRC will be forwarded
[Logs]    [2024-02-04T16:30:39.131Z] [packet-forwarder] INFO: packets received with a CRC error will NOT be forwarded
[Logs]    [2024-02-04T16:30:39.131Z] [packet-forwarder] INFO: packets received with no CRC will NOT be forwarded
[Logs]    [2024-02-04T16:30:39.131Z] [packet-forwarder] INFO: Reference latitude is configured to 0.000000 deg
[Logs]    [2024-02-04T16:30:39.131Z] [packet-forwarder] INFO: Reference longitude is configured to 0.000000 deg
[Logs]    [2024-02-04T16:30:39.131Z] [packet-forwarder] INFO: Reference altitude is configured to 0 meters
[Logs]    [2024-02-04T16:30:39.132Z] [packet-forwarder] INFO: fake GPS is enabled
[Logs]    [2024-02-04T16:30:39.132Z] [packet-forwarder] INFO: global_conf.json does contain a JSON object named debug_conf, parsing debug parameters
[Logs]    [2024-02-04T16:30:39.132Z] [packet-forwarder] INFO: got 2 debug reference payload
[Logs]    [2024-02-04T16:30:39.132Z] [packet-forwarder] INFO: reference payload ID 0 is 0xCAFE1234
[Logs]    [2024-02-04T16:30:39.132Z] [packet-forwarder] INFO: reference payload ID 1 is 0xCAFE2345
[Logs]    [2024-02-04T16:30:39.132Z] [packet-forwarder] INFO: setting debug log file name to loragw_hal.log
[Logs]    [2024-02-04T16:30:39.133Z] [packet-forwarder] INFO: found configuration file local_conf.json, parsing it
[Logs]    [2024-02-04T16:30:39.133Z] [packet-forwarder] INFO: local_conf.json does contain a JSON object named gateway_conf, parsing gateway parameters
[Logs]    [2024-02-04T16:30:39.133Z] [packet-forwarder] INFO: gateway MAC address is configured to 0000E45F01370DDF
[Logs]    [2024-02-04T16:30:39.133Z] [packet-forwarder] INFO: server hostname or IP address is configured to "multiplexer"
[Logs]    [2024-02-04T16:30:39.134Z] [packet-forwarder] INFO: upstream port is configured to "1681"
[Logs]    [2024-02-04T16:30:39.134Z] [packet-forwarder] INFO: downstream port is configured to "1681"
[Logs]    [2024-02-04T16:30:39.134Z] [packet-forwarder] INFO: downstream keep-alive interval is configured to 10 seconds
[Logs]    [2024-02-04T16:30:39.134Z] [packet-forwarder] INFO: statistics display interval is configured to 30 seconds
[Logs]    [2024-02-04T16:30:39.134Z] [packet-forwarder] INFO: upstream PUSH_DATA time-out is configured to 100 ms
[Logs]    [2024-02-04T16:30:39.134Z] [packet-forwarder] INFO: packets received with a valid CRC will be forwarded
[Logs]    [2024-02-04T16:30:39.135Z] [packet-forwarder] INFO: packets received with a CRC error will NOT be forwarded
[Logs]    [2024-02-04T16:30:39.135Z] [packet-forwarder] INFO: packets received with no CRC will NOT be forwarded
[Logs]    [2024-02-04T16:30:39.135Z] [packet-forwarder] INFO: Reference latitude is configured to 0.000000 deg
[Logs]    [2024-02-04T16:30:39.135Z] [packet-forwarder] INFO: Reference longitude is configured to 0.000000 deg
[Logs]    [2024-02-04T16:30:39.135Z] [packet-forwarder] INFO: Reference altitude is configured to 0 meters
[Logs]    [2024-02-04T16:30:39.136Z] [packet-forwarder] INFO: fake GPS is enabled
[Logs]    [2024-02-04T16:30:39.137Z] [packet-forwarder] CONCENTRATOR_RESET_PIN parameter not passed in, using value from the environment (val=25)
[Logs]    [2024-02-04T16:30:39.348Z] [packet-forwarder] CoreCell reset through GPIO25...
[Logs]    [2024-02-04T16:30:39.561Z] [packet-forwarder] Opening SPI communication interface
[Logs]    [2024-02-04T16:30:39.562Z] [packet-forwarder] Note: chip version is 0x10 (v1.0)
[Logs]    [2024-02-04T16:30:41.785Z] [packet-forwarder] INFO: using legacy timestamp
[Logs]    [2024-02-04T16:30:41.810Z] [packet-forwarder] INFO: LoRa Service modem: configuring preamble size to 8 symbols
[Logs]    [2024-02-04T16:30:42.042Z] [packet-forwarder] ARB: dual demodulation disabled for all SF
[Logs]    [2024-02-04T16:30:42.045Z] [packet-forwarder] INFO: [main] concentrator started, packet can now be received
[Logs]    [2024-02-04T16:30:42.047Z] [packet-forwarder] INFO: concentrator EUI: 0x0016c001ff1bf6c0
[Logs]    [2024-02-04T16:30:42.048Z] [packet-forwarder] INFO: concentrator chip model ID: 0x00
[Logs]    [2024-02-04T16:30:42.051Z] [multiplexer] Feb 04 16:30:42.049 INFO New packet forwarder client: 00:00:E4:5F:01:37:0D:DF, 172.17.0.2:35576
[Logs]    [2024-02-04T16:30:42.051Z] [packet-forwarder] INFO: [down] PULL_ACK received in 0 ms
[Logs]    [2024-02-04T16:30:42.067Z] [multiplexer] Feb 04 16:30:42.067 INFO Connecting to server helium-miner:1680 on behalf of 00:00:E4:5F:01:37:0D:DF
[Logs]    [2024-02-04T16:30:42.068Z] [helium-miner] 2024-02-04T16:30:42.068209Z  INFO run: gateway_rs::gateway: new packet forwarder client mac=00:00:E4:5F:01:37:0D:DF addr=172.17.0.4:49570
[Logs]    [2024-02-04T16:30:44.810Z] [gateway-config] 2024-02-04 16:30:44,808 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/venv/lib/python3.9/site-packages/gatewayconfig/processors/diagnostics_processor.py:(55) - Running DiagnosticsProcessor
[Logs]    [2024-02-04T16:30:44.812Z] [gateway-config] 2024-02-04 16:30:44,809 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).read_diagnostics_and_get_ok -- /opt/venv/lib/python3.9/site-packages/gatewayconfig/processors/diagnostics_processor.py:(60) - Reading diagnostics from http://diagnostics/json
[Logs]    [2024-02-04T16:30:44.837Z] [diagnostics] INFO:root:Running periodic hardware diagnostics
[Logs]    [2024-02-04T16:30:45.399Z] [diagnostics] 2024-02-04 16:30:45,398 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(38) - gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:30:45.401Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stdout: b'{\n  "key": "112R9Jvz4YVSoDmveV9TCKu2MuRUVhHWpZfDA6FgGNaGVay111MQ",\n  "name": "basic-tartan-orca"\n}\n'
[Logs]    [2024-02-04T16:30:45.401Z] [diagnostics] 2024-02-04 16:30:45,399 - [INFO] - hm_pyhelper.miner_param - (miner_param.py).run_gateway_mfr -- /opt/python-dependencies/lib/python3.11/site-packages/hm_pyhelper/miner_param.py:(39) - gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:30:45.402Z] [diagnostics] INFO:hm_pyhelper.miner_param:gateway_mfr response stderr: b''
[Logs]    [2024-02-04T16:30:45.402Z] [diagnostics] 2024-02-04 16:30:45,401 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(106) - Retrieving list of BLE device(s)
[Logs]    [2024-02-04T16:30:45.403Z] [diagnostics] INFO:hw_diag.utilities.hardware:Retrieving list of BLE device(s)
[Logs]    [2024-02-04T16:30:45.413Z] [diagnostics] 2024-02-04 16:30:45,412 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_ble_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(129) - Found the following BLE Devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:30:45.413Z] [diagnostics] INFO:hw_diag.utilities.hardware:Found the following BLE Devices: [{'Address': 'E4:5F:01:37:0D:E1', 'Name': 'BlueZ 5.66', 'Powered': '1', 'Discoverable': '0', 'Pairable': '0', 'Discovering': '0'}]
[Logs]    [2024-02-04T16:30:45.414Z] [diagnostics] 2024-02-04 16:30:45,413 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(175) - Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:30:45.415Z] [diagnostics] INFO:hw_diag.utilities.hardware:Retrieving list of LTE device(s)
[Logs]    [2024-02-04T16:30:45.422Z] [diagnostics] 2024-02-04 16:30:45,421 - [INFO] - hw_diag.utilities.hardware - (hardware.py).get_lte_devices -- /opt/python-dependencies/lib/python3.11/site-packages/hw_diag/utilities/hardware.py:(202) - Found the following LTE Devices: []
[Logs]    [2024-02-04T16:30:45.422Z] [diagnostics] INFO:hw_diag.utilities.hardware:Found the following LTE Devices: []
[Logs]    [2024-02-04T16:30:45.424Z] [diagnostics] INFO:root:Diagnostics shipping not requested, skipping.
[Logs]    [2024-02-04T16:30:45.424Z] [diagnostics] INFO:root:Diagnostics complete
[Logs]    [2024-02-04T16:30:45.432Z] [gateway-config] 2024-02-04 16:30:45,432 - [DEBUG] - gatewayconfig.processors.diagnostics_processor - (diagnostics_processor.py).run -- /opt/venv/lib/python3.9/site-packages/gatewayconfig/processors/diagnostics_processor.py:(57) - <gatewayconfig.gatewayconfig_shared_state.GatewayconfigSharedState object at 0x7fb16cc1f0>
[Logs]    [2024-02-04T16:30:52.250Z] [packet-forwarder] INFO: [down] PULL_ACK received in 0 ms
[Logs]    [2024-02-04T16:31:02.450Z] [packet-forwarder] INFO: [down] PULL_ACK received in 0 ms