A little excited? - SSL Error on download

From terminal when trying to install -

curl: (60) SSL certificate problem: certificate is not yet valid

More details here: https://curl.haxx.se/docs/sslcerts.html

curl failed to verify the legitimacy of the server and therefore could not

establish a secure connection to it. To learn more about this situation and

how to fix it, please visit the web page mentioned above.


Guessing I’m a little too early to install??

@Saeed @ensar

Would love to get this Power Management up and running! Can’t get the software to download and install. Either through the cloud management or the open source link you mentioned!

Chomping at the bit to give this a try!

Hi @geoffrey.bolte,

Check system time. SSL(encrypted connections) will not work unless the correct time is set.

1 Like

Guess I was a little excited. In using an old install the system time was not updated. Good to go now!

1 Like

@ensar

On the install the raspberry shutdown after install is that normal? I noticed the agent ran on boot, but am unable to see the hat in the cloud monitor. Have wifi IP address and connected to Internet.

I do have the cellular IOT hat software installed.

Could you please share the output once you type systemctl status pms_agent.service?

Thanks @ensar was wondering what the service name was.

It failed according to the output, I ended up -

sudo systemctl disable pms_agent.service
sudo systemctl enable pms_agent.service
sudo systemctl start pms_agent.service

It then worked.

After reboot it failed again.

● pms_agent.service - Sixfab PMS Agent
Loaded: loaded (/etc/systemd/system/pms_agent.service; enabled; vendor preset: enabled)
Active: **failed** (Result: exit-code) since Sat 2020-04-25 20:48:02 EDT; 2min 13s ago
Process: 561 ExecStart=/usr/bin/python3 -u agent.py **(code=exited, status=1/FAILURE)**
Main PID: 561 (code=exited, status=1/FAILURE)
Apr 25 20:48:02 raspilapse1 systemd[1]: pms_agent.service: Service RestartSec=100ms expired, scheduling restart.
Apr 25 20:48:02 raspilapse1 systemd[1]: pms_agent.service: Scheduled restart job, restart counter is at 5.
Apr 25 20:48:02 raspilapse1 systemd[1]: Stopped Sixfab PMS Agent.
Apr 25 20:48:02 raspilapse1 systemd[1]: **pms_agent.service: Start request repeated too quickly.**
Apr 25 20:48:02 raspilapse1 systemd[1]: **pms_agent.service: Failed with result 'exit-code'.**
Apr 25 20:48:02 raspilapse1 systemd[1]: **Failed to start Sixfab PMS Agent.**

Currently going through the journalctl -e to see if I can see what happened.

@ensar

Looking through the journalctl -e looks as though the service starts before the wifi connects so the python script cannot function I believe??

Apr 25 21:27:03 raspilapse1 systemd[1]: Started Sixfab PMS Agent.

Apr 25 21:27:03 raspilapse1 systemd[1]: Started Permit User Sessions.

Apr 25 21:27:03 raspilapse1 systemd[1]: Started /etc/rc.local Compatibility.

Apr 25 21:27:03 raspilapse1 systemd[1]: Starting Terminate Plymouth Boot Screen…

Apr 25 21:27:03 raspilapse1 systemd[1]: Starting Hold until boot process finishes up…

Apr 25 21:27:03 raspilapse1 dhcpcd-run-hooks[444]: wlan0: starting wpa_supplicant

Apr 25 21:27:03 raspilapse1 systemd[1]: Received SIGRTMIN+21 from PID 154 (plymouthd).

Apr 25 21:27:03 raspilapse1 systemd[1]: Received SIGRTMIN+21 from PID 154 (plymouthd).

Apr 25 21:27:03 raspilapse1 systemd[1]: plymouth-quit.service: Succeeded.

Apr 25 21:27:03 raspilapse1 systemd[1]: Started Terminate Plymouth Boot Screen.

Apr 25 21:27:03 raspilapse1 systemd[1]: plymouth-start.service: Succeeded.

Apr 25 21:27:03 raspilapse1 systemd[1]: plymouth-quit-wait.service: Succeeded.

Apr 25 21:27:03 raspilapse1 systemd[1]: Started Hold until boot process finishes up.

Apr 25 21:27:03 raspilapse1 systemd[1]: Started Getty on tty1.

Apr 25 21:27:03 raspilapse1 systemd[1]: Reached target Login Prompts.

Apr 25 21:27:03 raspilapse1 kernel: IPv6: ADDRCONF(NETDEV_UP): wlan0: link is not ready

Apr 25 21:27:03 raspilapse1 kernel: brcmfmac: power management disabled

Apr 25 21:27:04 raspilapse1 sshd[449]: Server listening on 0.0.0.0 port 22.

Apr 25 21:27:04 raspilapse1 sshd[449]: Server listening on :: port 22.

Apr 25 21:27:04 raspilapse1 systemd[1]: Started OpenBSD Secure Shell server.

Apr 25 21:27:04 raspilapse1 raspi-config[328]: Checking if shift key is held down: No. Switching to ondemand scaling governor.

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: connected to Access Point `’

Apr 25 21:27:04 raspilapse1 systemd[1]: Started LSB: Switch to ondemand cpu governor (unless shift key is pressed).

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: eth0: waiting for carrier

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: waiting for carrier

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: carrier acquired

Apr 25 21:27:04 raspilapse1 kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn’t capable of remote wakeup

Apr 25 21:27:04 raspilapse1 kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: DUID 00:01:00:01:25:d8:36:06:b8:27:eb:94:78:8c

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: IAID eb:94:78:8c

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: adding address fe80::8298:95e8:ccff:50bf

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::8298:95e8:ccff:50bf.

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: carrier lost

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: New relevant interface wlan0.IPv6 for mDNS.

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Registering new address record for fe80::8298:95e8:ccff:50bf on wlan0.*.

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: deleting address fe80::8298:95e8:ccff:50bf

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Withdrawing address record for fe80::8298:95e8:ccff:50bf on wlan0.

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::8298:95e8:ccff:50bf.

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Interface wlan0.IPv6 no longer relevant for mDNS.

Apr 25 21:27:04 raspilapse1 vncserver-x11[446]: ServerManager: Server started

Apr 25 21:27:04 raspilapse1 vncserver-x11[446]: ConsoleDisplay: Cannot find a running X server on vt1

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: carrier acquired

Apr 25 21:27:05 raspilapse1 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: connected to Access Point `CSWifi’

Apr 25 21:27:04 raspilapse1 kernel: smsc95xx 1-1.1:1.0 eth0: hardware isn’t capable of remote wakeup

Apr 25 21:27:04 raspilapse1 kernel: IPv6: ADDRCONF(NETDEV_UP): eth0: link is not ready

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: DUID 00:01:00:01:25:d8:36:06:b8:27:eb:94:78:8c

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: IAID eb:94:78:8c

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: adding address fe80::8298:95e8:ccff:50bf

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::8298:95e8:ccff:50bf.

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: carrier lost

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: New relevant interface wlan0.IPv6 for mDNS.

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Registering new address record for fe80::8298:95e8:ccff:50bf on wlan0.*.

Apr 25 21:27:04 raspilapse1 dhcpcd[412]: wlan0: deleting address fe80::8298:95e8:ccff:50bf

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Withdrawing address record for fe80::8298:95e8:ccff:50bf on wlan0.

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Leaving mDNS multicast group on interface wlan0.IPv6 with address fe80::8298:95e8:ccff:50bf.

Apr 25 21:27:04 raspilapse1 avahi-daemon[375]: Interface wlan0.IPv6 no longer relevant for mDNS.

Apr 25 21:27:04 raspilapse1 vncserver-x11[446]: ServerManager: Server started

Apr 25 21:27:04 raspilapse1 vncserver-x11[446]: ConsoleDisplay: Cannot find a running X server on vt1

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: carrier acquired

Apr 25 21:27:05 raspilapse1 kernel: IPv6: ADDRCONF(NETDEV_CHANGE): wlan0: link becomes ready

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: connected to Access Point `CSWifi’

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: IAID eb:94:78:8c

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: adding address fe80::8150:6729:34d0:7c04

Apr 25 21:27:05 raspilapse1 avahi-daemon[375]: Joining mDNS multicast group on interface wlan0.IPv6 with address fe80::8150:6729:34d0:7c04.

Apr 25 21:27:05 raspilapse1 avahi-daemon[375]: New relevant interface wlan0.IPv6 for mDNS.

Apr 25 21:27:05 raspilapse1 avahi-daemon[375]: Registering new address record for fe80::8150:6729:34d0:7c04 on wlan0.*.

Apr 25 21:27:05 raspilapse1 python3[438]: Traceback (most recent call last):

Apr 25 21:27:05 raspilapse1 python3[438]: File “agent.py”, line 30, in

Apr 25 21:27:05 raspilapse1 python3[438]: configs=configs

Apr 25 21:27:05 raspilapse1 python3[438]: File “/opt/sixfab/pms/agent/core/init.py”, line 40, in init

Apr 25 21:27:05 raspilapse1 python3[438]: client.connect(MQTT_HOST, MQTT_PORT, 50)

Apr 25 21:27:05 raspilapse1 python3[438]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 937, in connect

Apr 25 21:27:05 raspilapse1 python3[438]: return self.reconnect()

Apr 25 21:27:05 raspilapse1 python3[438]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 1071, in reconnect

Apr 25 21:27:05 raspilapse1 python3[438]: sock = self._create_socket_connection()

Apr 25 21:27:05 raspilapse1 python3[438]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 3522, in _create_socket_connection

Apr 25 21:27:05 raspilapse1 python3[438]: return socket.create_connection(addr, source_address=source, timeout=self._keepalive)

Apr 25 21:27:05 raspilapse1 python3[438]: File “/usr/lib/python3.7/socket.py”, line 707, in create_connection

Apr 25 21:27:05 raspilapse1 python3[438]: for res in getaddrinfo(host, port, 0, SOCK_STREAM):

Apr 25 21:27:05 raspilapse1 python3[438]: File “/usr/lib/python3.7/socket.py”, line 748, in getaddrinfo

Apr 25 21:27:05 raspilapse1 python3[438]: for res in _socket.getaddrinfo(host, port, family, type, proto, flags):

Apr 25 21:27:05 raspilapse1 python3[438]: socket.gaierror: [Errno -3] Temporary failure in name resolution

Apr 25 21:27:05 raspilapse1 systemd[1]: pms_agent.service: Main process exited, code=exited, status=1/FAILURE

Apr 25 21:27:05 raspilapse1 systemd[1]: pms_agent.service: Failed with result ‘exit-code’.

Apr 25 21:27:05 raspilapse1 systemd[1]: pms_agent.service: Service RestartSec=100ms expired, scheduling restart.

Apr 25 21:27:05 raspilapse1 systemd[1]: pms_agent.service: Scheduled restart job, restart counter is at 1.

Apr 25 21:27:05 raspilapse1 systemd[1]: Stopped Sixfab PMS Agent.

Apr 25 21:27:05 raspilapse1 systemd[1]: Started Sixfab PMS Agent.

Apr 25 21:27:05 raspilapse1 dhcpcd[412]: wlan0: soliciting an IPv6 router

Apr 25 21:27:05 raspilapse1 systemd[1]: systemd-rfkill.service: Succeeded.

Apr 25 21:27:06 raspilapse1 dhcpcd[412]: wlan0: rebinding lease of 10.0.1.100

Apr 25 21:27:06 raspilapse1 dhcpcd[412]: wlan0: probing address 10.0.1.100/24

Apr 25 21:27:06 raspilapse1 python3[473]: Traceback (most recent call last):

Apr 25 21:27:06 raspilapse1 python3[473]: File “agent.py”, line 30, in

Apr 25 21:27:06 raspilapse1 python3[473]: configs=configs

Apr 25 21:27:06 raspilapse1 python3[473]: File “/opt/sixfab/pms/agent/core/init.py”, line 40, in init

Apr 25 21:27:06 raspilapse1 python3[473]: client.connect(MQTT_HOST, MQTT_PORT, 50)

Apr 25 21:27:06 raspilapse1 python3[473]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 937, in connect

Apr 25 21:27:06 raspilapse1 python3[473]: return self.reconnect()

Apr 25 21:27:06 raspilapse1 python3[473]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 1071, in reconnect

Apr 25 21:27:06 raspilapse1 python3[473]: sock = self._create_socket_connection()

Apr 25 21:27:06 raspilapse1 python3[473]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 3522, in _create_socket_connection

Apr 25 21:27:06 raspilapse1 python3[473]: return socket.create_connection(addr, source_address=source, timeout=self._keepalive)

Apr 25 21:27:06 raspilapse1 python3[473]: File “/usr/lib/python3.7/socket.py”, line 707, in create_connection

Apr 25 21:27:06 raspilapse1 python3[473]: for res in getaddrinfo(host, port, 0, SOCK_STREAM):

Apr 25 21:27:06 raspilapse1 python3[473]: File “/usr/lib/python3.7/socket.py”, line 748, in getaddrinfo

Apr 25 21:27:06 raspilapse1 python3[473]: for res in _socket.getaddrinfo(host, port, family, type, proto, flags):

Apr 25 21:27:06 raspilapse1 python3[473]: socket.gaierror: [Errno -3] Temporary failure in name resolution

Apr 25 21:27:06 raspilapse1 systemd[1]: pms_agent.service: Main process exited, code=exited, status=1/FAILURE

Apr 25 21:27:06 raspilapse1 systemd[1]: pms_agent.service: Failed with result ‘exit-code’.

Apr 25 21:27:06 raspilapse1 systemd[1]: pms_agent.service: Service RestartSec=100ms expired, scheduling restart.

Apr 25 21:27:06 raspilapse1 systemd[1]: pms_agent.service: Scheduled restart job, restart counter is at 2.

Apr 25 21:27:06 raspilapse1 systemd[1]: Stopped Sixfab PMS Agent.

Apr 25 21:27:06 raspilapse1 systemd[1]: Started Sixfab PMS Agent.

Apr 25 21:27:07 raspilapse1 python3[476]: Traceback (most recent call last):

Apr 25 21:27:07 raspilapse1 python3[476]: File “agent.py”, line 30, in

Apr 25 21:27:07 raspilapse1 python3[476]: configs=configs

Apr 25 21:27:07 raspilapse1 python3[476]: File “/opt/sixfab/pms/agent/core/init.py”, line 40, in init

Apr 25 21:27:07 raspilapse1 python3[476]: client.connect(MQTT_HOST, MQTT_PORT, 50)

Apr 25 21:27:07 raspilapse1 python3[476]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 937, in connect

Apr 25 21:27:07 raspilapse1 python3[476]: return self.reconnect()

Apr 25 21:27:07 raspilapse1 python3[476]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 1071, in reconnect

Apr 25 21:27:07 raspilapse1 python3[476]: sock = self._create_socket_connection()

Apr 25 21:27:07 raspilapse1 python3[476]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 3522, in _create_socket_connection

Apr 25 21:27:07 raspilapse1 python3[476]: return socket.create_connection(addr, source_address=source, timeout=self._keepalive)

Apr 25 21:27:07 raspilapse1 python3[476]: File “/usr/lib/python3.7/socket.py”, line 707, in create_connection

Apr 25 21:27:07 raspilapse1 python3[476]: for res in getaddrinfo(host, port, 0, SOCK_STREAM):

Apr 25 21:27:07 raspilapse1 python3[476]: File “/usr/lib/python3.7/socket.py”, line 748, in getaddrinfo

Apr 25 21:27:07 raspilapse1 python3[476]: for res in _socket.getaddrinfo(host, port, family, type, proto, flags):

Apr 25 21:27:07 raspilapse1 python3[476]: socket.gaierror: [Errno -3] Temporary failure in name resolution

Apr 25 21:27:07 raspilapse1 systemd[1]: pms_agent.service: Main process exited, code=exited, status=1/FAILURE

Apr 25 21:27:07 raspilapse1 systemd[1]: pms_agent.service: Failed with result ‘exit-code’.

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: Core ver 2.22

Apr 25 21:27:07 raspilapse1 kernel: NET: Registered protocol family 31

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: HCI device and connection manager initialized

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: HCI socket layer initialized

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: L2CAP socket layer initialized

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: SCO socket layer initialized

Apr 25 21:27:07 raspilapse1 btuart[337]: bcm43xx_init

Apr 25 21:27:07 raspilapse1 btuart[337]: Flash firmware /lib/firmware/brcm/BCM43430A1.hcd

Apr 25 21:27:07 raspilapse1 btuart[337]: Set BDADDR UART: b8:27:eb:6b:87:73

Apr 25 21:27:07 raspilapse1 btuart[337]: Set Controller UART speed to 921600 bit/s

Apr 25 21:27:07 raspilapse1 btuart[337]: Device setup complete

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: HCI UART driver ver 2.3

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: HCI UART protocol H4 registered

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: HCI UART protocol Three-wire (H5) registered

Apr 25 21:27:07 raspilapse1 kernel: Bluetooth: HCI UART protocol Broadcom registered

Apr 25 21:27:07 raspilapse1 systemd[1]: Started Configure Bluetooth Modems connected by UART.

Apr 25 21:27:07 raspilapse1 systemd[1]: pms_agent.service: Service RestartSec=100ms expired, scheduling restart.

Apr 25 21:27:07 raspilapse1 systemd[1]: pms_agent.service: Scheduled restart job, restart counter is at 3.

Apr 25 21:27:07 raspilapse1 systemd[1]: Stopped Sixfab PMS Agent.

Apr 25 21:27:07 raspilapse1 systemd[1]: Started Sixfab PMS Agent.

Apr 25 21:27:07 raspilapse1 systemd[1]: Reached target Multi-User System.

Apr 25 21:27:07 raspilapse1 systemd[1]: Starting Update UTMP about System Runlevel Changes…

Apr 25 21:27:07 raspilapse1 systemd[1]: Starting Load/Save RF Kill Switch Status…

Apr 25 21:27:07 raspilapse1 systemd[1]: Started Load/Save RF Kill Switch Status.

Apr 25 21:27:07 raspilapse1 systemd[1]: Created slice system-bthelper.slice.

Apr 25 21:27:07 raspilapse1 systemd[1]: Starting Bluetooth service…

Apr 25 21:27:07 raspilapse1 systemd[1]: systemd-update-utmp-runlevel.service: Succeeded.

Apr 25 21:27:07 raspilapse1 systemd[1]: Started Update UTMP about System Runlevel Changes.

Apr 25 21:27:07 raspilapse1 bluetoothd[491]: Bluetooth daemon 5.50

Apr 25 21:27:08 raspilapse1 systemd[1]: Started Bluetooth service.

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: Starting SDP server

Apr 25 21:27:08 raspilapse1 systemd[1]: Started BluezALSA proxy.

Apr 25 21:27:08 raspilapse1 systemd[1]: Started Raspberry Pi bluetooth helper.

Apr 25 21:27:08 raspilapse1 systemd[1]: Reached target Bluetooth.

Apr 25 21:27:08 raspilapse1 systemd[1]: Startup finished in 2.130s (kernel) + 12.039s (userspace) = 14.170s.

Apr 25 21:27:08 raspilapse1 kernel: Bluetooth: BNEP (Ethernet Emulation) ver 1.3

Apr 25 21:27:08 raspilapse1 kernel: Bluetooth: BNEP filters: protocol multicast

Apr 25 21:27:08 raspilapse1 kernel: Bluetooth: BNEP socket layer initialized

Apr 25 21:27:08 raspilapse1 dbus-daemon[343]: [system] Activating via systemd: service name=‘org.freedesktop.hostname1’ unit=‘dbus-org.freedesktop.hostname1.service’ requested by ‘:1.5’ (uid=0 pid=491 comm="/usr/lib/bluetooth/bluetoothd "

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: Bluetooth management interface 1.14 initialized

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: Sap driver initialization failed.

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: sap-server: Operation not permitted (1)

Apr 25 21:27:08 raspilapse1 systemd[1]: bthelper@hci0.service: Succeeded.

Apr 25 21:27:08 raspilapse1 systemd[1]: Starting Hostname Service…

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/Source/1

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: Endpoint registered: sender=:1.6 path=/org/bluez/hci0/A2DP/SBC/Source/2

Apr 25 21:27:08 raspilapse1 kernel: Bluetooth: RFCOMM TTY layer initialized

Apr 25 21:27:08 raspilapse1 kernel: Bluetooth: RFCOMM socket layer initialized

Apr 25 21:27:08 raspilapse1 kernel: Bluetooth: RFCOMM ver 1.11

Apr 25 21:27:08 raspilapse1 bluetoothd[491]: Failed to set privacy: Rejected (0x0b)

Apr 25 21:27:08 raspilapse1 python3[487]: Traceback (most recent call last):

Apr 25 21:27:08 raspilapse1 python3[487]: File “agent.py”, line 30, in

Apr 25 21:27:08 raspilapse1 python3[487]: configs=configs

Apr 25 21:27:08 raspilapse1 python3[487]: File “/opt/sixfab/pms/agent/core/init.py”, line 40, in init

Apr 25 21:27:08 raspilapse1 python3[487]: client.connect(MQTT_HOST, MQTT_PORT, 50)

Apr 25 21:27:08 raspilapse1 python3[487]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 937, in connect

Apr 25 21:27:08 raspilapse1 python3[487]: return self.reconnect()

Apr 25 21:27:08 raspilapse1 python3[487]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 1071, in reconnect

Apr 25 21:27:08 raspilapse1 python3[487]: sock = self._create_socket_connection()

Apr 25 21:27:08 raspilapse1 python3[487]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 3522, in _create_socket_connection

Apr 25 21:27:08 raspilapse1 python3[487]: return socket.create_connection(addr, source_address=source, timeout=self._keepalive)

Apr 25 21:27:08 raspilapse1 python3[487]: File “/usr/lib/python3.7/socket.py”, line 707, in create_connection

Apr 25 21:27:08 raspilapse1 python3[487]: for res in getaddrinfo(host, port, 0, SOCK_STREAM):

Apr 25 21:27:08 raspilapse1 python3[487]: File “/usr/lib/python3.7/socket.py”, line 748, in getaddrinfo

Apr 25 21:27:08 raspilapse1 python3[487]: for res in _socket.getaddrinfo(host, port, family, type, proto, flags):

Apr 25 21:27:08 raspilapse1 python3[487]: socket.gaierror: [Errno -3] Temporary failure in name resolution

Apr 25 21:27:08 raspilapse1 systemd[1]: pms_agent.service: Main process exited, code=exited, status=1/FAILURE

Apr 25 21:27:08 raspilapse1 systemd[1]: pms_agent.service: Failed with result ‘exit-code’.

Apr 25 21:27:08 raspilapse1 dbus-daemon[343]: [system] Successfully activated service ‘org.freedesktop.hostname1’

Apr 25 21:27:08 raspilapse1 systemd[1]: Started Hostname Service.

Apr 25 21:27:08 raspilapse1 systemd[1]: pms_agent.service: Service RestartSec=100ms expired, scheduling restart.

Apr 25 21:27:08 raspilapse1 systemd[1]: pms_agent.service: Scheduled restart job, restart counter is at 4.

Apr 25 21:27:08 raspilapse1 systemd[1]: Stopped Sixfab PMS Agent.

Apr 25 21:27:08 raspilapse1 systemd[1]: Started Sixfab PMS Agent.

Apr 25 21:27:09 raspilapse1 python3[506]: Traceback (most recent call last):

Apr 25 21:27:09 raspilapse1 python3[506]: File “agent.py”, line 30, in

Apr 25 21:27:09 raspilapse1 python3[506]: configs=configs

Apr 25 21:27:09 raspilapse1 python3[506]: File “/opt/sixfab/pms/agent/core/init.py”, line 40, in init

Apr 25 21:27:09 raspilapse1 python3[506]: client.connect(MQTT_HOST, MQTT_PORT, 50)

Apr 25 21:27:09 raspilapse1 python3[506]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 937, in connect

Apr 25 21:27:09 raspilapse1 python3[506]: return self.reconnect()

Apr 25 21:27:09 raspilapse1 python3[506]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 1071, in reconnect

Apr 25 21:27:09 raspilapse1 python3[506]: sock = self._create_socket_connection()

Apr 25 21:27:09 raspilapse1 python3[506]: File “/usr/local/lib/python3.7/dist-packages/paho/mqtt/client.py”, line 3522, in _create_socket_connection

Apr 25 21:27:09 raspilapse1 python3[506]: return socket.create_connection(addr, source_address=source, timeout=self._keepalive)

Apr 25 21:27:09 raspilapse1 python3[506]: File “/usr/lib/python3.7/socket.py”, line 707, in create_connection

Apr 25 21:27:09 raspilapse1 python3[506]: for res in getaddrinfo(host, port, 0, SOCK_STREAM):

Apr 25 21:27:09 raspilapse1 python3[506]: File “/usr/lib/python3.7/socket.py”, line 748, in getaddrinfo

Apr 25 21:27:09 raspilapse1 python3[506]: for res in _socket.getaddrinfo(host, port, family, type, proto, flags):

Apr 25 21:27:09 raspilapse1 python3[506]: socket.gaierror: [Errno -3] Temporary failure in name resolution

Apr 25 21:27:09 raspilapse1 systemd[1]: pms_agent.service: Main process exited, code=exited, status=1/FAILURE

Apr 25 21:27:09 raspilapse1 systemd[1]: pms_agent.service: Failed with result ‘exit-code’.

Apr 25 21:27:09 raspilapse1 systemd[1]: pms_agent.service: Service RestartSec=100ms expired, scheduling restart.

Apr 25 21:27:09 raspilapse1 systemd[1]: pms_agent.service: Scheduled restart job, restart counter is at 5.

Apr 25 21:27:09 raspilapse1 systemd[1]: Stopped Sixfab PMS Agent.

Apr 25 21:27:09 raspilapse1 systemd[1]: pms_agent.service: Start request repeated too quickly.

Apr 25 21:27:09 raspilapse1 systemd[1]: pms_agent.service: Failed with result ‘exit-code’.

Apr 25 21:27:09 raspilapse1 systemd[1]: Failed to start Sixfab PMS Agent.

Apr 25 21:27:09 raspilapse1 sudo[418]: pam_unix(sudo:session): session closed for user root

Apr 25 21:27:09 raspilapse1 CRON[354]: pam_unix(cron:session): session closed for user root

Apr 25 21:27:10 raspilapse1 dhcpcd[412]: wlan0: leased 10.0.1.100 for 86400 seconds

Apr 25 21:27:10 raspilapse1 avahi-daemon[375]: Joining mDNS multicast group on interface wlan0.IPv4 with address 10.0.1.100.

Apr 25 21:27:10 raspilapse1 dhcpcd[412]: wlan0: adding route to 10.0.1.0/24

Apr 25 21:27:10 raspilapse1 dhcpcd[412]: wlan0: adding default route via 10.0.1.1

Apr 25 21:27:10 raspilapse1 avahi-daemon[375]: New relevant interface wlan0.IPv4 for mDNS.

Apr 25 21:27:10 raspilapse1 avahi-daemon[375]: Registering new address record for 10.0.1.100 on wlan0.IPv4.

I’m looking through the restart settings to see what works, only issue I see is when I switch over to cellular connectivity I know it takes a little longer depending on location.

@ensar @saeed

New issue although I haven’t been able to resolve the current service not being able to start at boot.

The dashboard is really nice and I can see a benefit to my projects to change start and shutdown times. I first updated the firmware as requested. I was then able to set through the dashboard a start time and a soft shutdown to do some testing.

The system did not start at the specified time this morning, so I initiated a hard boot. After that I restarted the service and the pi immediately went to shutdown. Guessing the HAT has the wrong time (telling the pi to shutdown)? How do I go about changing the RTC as well as Start/Shutdown times from the PI?

Also in the dashboard what are the differences between scheduled Soft Shutdown or a scheduled Hard Shutdown. And what would be the reason to schedule a hard shutdown, as I would assume you can’t restart the PI after that?

I understand a lot of questions, and could be answered in documentation that you are currently finishing up. Just would like to get this to work and test!

@ensar @saeed so after some digging I had the service running again without shutting down.

I did set up a scheduled event through the dashboard after that to test. Set it up to soft reboot at 14:00 and it didn’t. I even tested it with changing the Time Zone in the dashboard and still nothing.

I did notice that the J2 button doesn’t seem to do anything when pushed.

running i2cdetect I have the board detected at 41. But unsure what to do to stop the Pi from restarting when the service actually starts up.