Windows Installation stuck on timer:starting

Cheesenwine · June 13, 2019, 12:17pm

Hi all,

I’l start with “totally new to Python”. I tried to install Hassio on my Windows 10 today, downloaded all the latest versions of everything and began install as per the various instructions. Sound’s simple enough… The first part of installing homeassistant worked fine, but I got many errors when I ran py -m homeassistant --open-ui.
Eg,

ModuleNotFoundError: No module named ‘hass_nabucasa’
ModuleNotFoundError: No module named ‘hass_frontend’
as well as huge pain with pycryptodome

I fixed each issue separately by running the following 1 by 1 as I worked out what’s missing…

pip install --upgrade pip
python -m pip install --upgrade pip
pip install --upgrade setuptools
pip install wheel
pip uninstall pycrypto
pip install pycryptodome
pip3 install sqlalchemy
pip3 install aiohttp_cors
pip3 install xmltodict
pip install zeroconf
pip3 install hass_nabucasa
pip install hass_frontend
reboot machine
installed some of these again, but hass_frontend is no longer installing

Eventually I got the command py -m homeassistant --open-ui to run without visible errors, but once it finally reaches ** INFO (MainThread) [homeassistant.core] Timer:starting**, it just sits the frozen. Nothing else happens.

I feels like I had to WAY too many manual fixes to install something who’s instructions are literally 2 simple commands.

Any idea how to get this thing working?

This is the full info in the console when I try to run it:

Unable to find configuration. Creating default one in C:\Users\Corryn\AppData\Roaming.homeassistant
Config directory: C:\Users\Corryn\AppData\Roaming.homeassistant
2019-06-13 22:04:18 INFO (SyncWorker_0) [homeassistant.util.package] Attempting install of pyotp==2.2.7
2019-06-13 22:04:20 INFO (SyncWorker_1) [homeassistant.util.package] Attempting install of PyQRCode==1.2.1
2019-06-13 22:04:22 INFO (SyncWorker_5) [homeassistant.loader] Loaded script from homeassistant.components.script
2019-06-13 22:04:22 INFO (SyncWorker_4) [homeassistant.loader] Loaded sensor from homeassistant.components.sensor
2019-06-13 22:04:22 INFO (SyncWorker_2) [homeassistant.loader] Loaded automation from homeassistant.components.automation
2019-06-13 22:04:22 INFO (SyncWorker_2) [homeassistant.loader] Loaded tts from homeassistant.components.tts
2019-06-13 22:04:22 INFO (SyncWorker_1) [homeassistant.loader] Loaded default_config from homeassistant.components.default_config
2019-06-13 22:04:22 INFO (SyncWorker_8) [homeassistant.loader] Loaded group from homeassistant.components.group
2019-06-13 22:04:22 INFO (SyncWorker_6) [homeassistant.loader] Loaded homeassistant from homeassistant.components.homeassistant
2019-06-13 22:04:22 INFO (SyncWorker_6) [homeassistant.loader] Loaded persistent_notification from homeassistant.components.persistent_notification
2019-06-13 22:04:22 INFO (SyncWorker_0) [homeassistant.loader] Loaded http from homeassistant.components.http
2019-06-13 22:04:22 INFO (MainThread) [homeassistant.setup] Setting up homeassistant
2019-06-13 22:04:22 INFO (MainThread) [homeassistant.setup] Setup of domain homeassistant took 0.0 seconds.
2019-06-13 22:04:22 INFO (MainThread) [homeassistant.setup] Setting up persistent_notification
2019-06-13 22:04:22 INFO (MainThread) [homeassistant.setup] Setup of domain persistent_notification took 0.0 seconds.
2019-06-13 22:04:22 INFO (SyncWorker_7) [homeassistant.loader] Loaded webhook from homeassistant.components.webhook
2019-06-13 22:04:22 INFO (SyncWorker_2) [homeassistant.loader] Loaded cloud from homeassistant.components.cloud
2019-06-13 22:04:22 INFO (SyncWorker_12) [homeassistant.loader] Loaded config from homeassistant.components.config
2019-06-13 22:04:22 INFO (SyncWorker_5) [homeassistant.loader] Loaded conversation from homeassistant.components.conversation
2019-06-13 22:04:22 INFO (SyncWorker_8) [homeassistant.loader] Loaded frontend from homeassistant.components.frontend
2019-06-13 22:04:23 INFO (SyncWorker_14) [homeassistant.loader] Loaded api from homeassistant.components.api
2019-06-13 22:04:23 INFO (SyncWorker_9) [homeassistant.loader] Loaded auth from homeassistant.components.auth
2019-06-13 22:04:23 INFO (SyncWorker_6) [homeassistant.loader] Loaded lovelace from homeassistant.components.lovelace
2019-06-13 22:04:23 INFO (SyncWorker_0) [homeassistant.loader] Loaded onboarding from homeassistant.components.onboarding
2019-06-13 22:04:23 INFO (SyncWorker_17) [homeassistant.loader] Loaded system_log from homeassistant.components.system_log
2019-06-13 22:04:23 INFO (SyncWorker_3) [homeassistant.loader] Loaded websocket_api from homeassistant.components.websocket_api
2019-06-13 22:04:23 INFO (SyncWorker_2) [homeassistant.loader] Loaded history from homeassistant.components.history
2019-06-13 22:04:23 INFO (SyncWorker_19) [homeassistant.loader] Loaded recorder from homeassistant.components.recorder
2019-06-13 22:04:23 INFO (SyncWorker_13) [homeassistant.loader] Loaded logbook from homeassistant.components.logbook
2019-06-13 22:04:23 INFO (SyncWorker_4) [homeassistant.loader] Loaded map from homeassistant.components.map
2019-06-13 22:04:23 INFO (SyncWorker_15) [homeassistant.loader] Loaded mobile_app from homeassistant.components.mobile_app
2019-06-13 22:04:23 INFO (SyncWorker_10) [homeassistant.loader] Loaded person from homeassistant.components.person
2019-06-13 22:04:23 INFO (SyncWorker_16) [homeassistant.loader] Loaded ssdp from homeassistant.components.ssdp
2019-06-13 22:04:23 INFO (SyncWorker_11) [homeassistant.loader] Loaded sun from homeassistant.components.sun
2019-06-13 22:04:23 INFO (SyncWorker_7) [homeassistant.loader] Loaded system_health from homeassistant.components.system_health
2019-06-13 22:04:23 INFO (SyncWorker_18) [homeassistant.loader] Loaded updater from homeassistant.components.updater
2019-06-13 22:04:23 INFO (SyncWorker_1) [homeassistant.loader] Loaded zeroconf from homeassistant.components.zeroconf
2019-06-13 22:04:23 INFO (MainThread) [homeassistant.bootstrap] Setting up {‘system_log’}
2019-06-13 22:04:23 INFO (MainThread) [homeassistant.setup] Setting up http
2019-06-13 22:04:23 INFO (MainThread) [homeassistant.setup] Setup of domain http took 0.0 seconds.
2019-06-13 22:04:23 INFO (MainThread) [homeassistant.setup] Setting up system_log
2019-06-13 22:04:23 INFO (MainThread) [homeassistant.setup] Setup of domain system_log took 0.0 seconds.
2019-06-13 22:04:23 INFO (SyncWorker_13) [homeassistant.util.package] Attempting install of sqlalchemy==1.3.3
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setting up recorder
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setup of domain recorder took 0.4 seconds.
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setting up lovelace
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setup of domain lovelace took 0.0 seconds.
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setting up person
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setting up group
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setup of domain group took 0.0 seconds.
2019-06-13 22:04:33 INFO (SyncWorker_15) [homeassistant.util.package] Attempting install of netdisco==2.6.0
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setting up sun
2019-06-13 22:04:33 INFO (MainThread) [homeassistant.setup] Setup of domain sun took 0.0 seconds.
2019-06-13 22:04:34 INFO (SyncWorker_10) [homeassistant.loader] Loaded yr from homeassistant.components.yr
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up api
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up script
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain script took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up system_health
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain system_health took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up config
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up conversation
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain conversation took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up websocket_api
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain websocket_api took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up webhook
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain webhook took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up auth
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain auth took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up history
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain history took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up sensor
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain api took 0.1 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain person took 0.5 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain config took 0.1 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up automation
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain automation took 0.0 seconds.
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setting up onboarding
2019-06-13 22:04:34 INFO (MainThread) [homeassistant.setup] Setup of domain onboarding took 0.0 seconds.
2019-06-13 22:04:38 ERROR (MainThread) [homeassistant.config] Unable to import ssdp: No module named ‘netdisco’
2019-06-13 22:04:38 ERROR (MainThread) [homeassistant.setup] Setup failed for ssdp: Invalid config.
2019-06-13 22:04:38 INFO (SyncWorker_2) [homeassistant.util.package] Attempting install of distro==1.4.0
2019-06-13 22:04:40 INFO (MainThread) [homeassistant.setup] Setting up updater
2019-06-13 22:04:40 INFO (MainThread) [homeassistant.setup] Setup of domain updater took 0.0 seconds.
2019-06-13 22:04:40 INFO (SyncWorker_5) [homeassistant.util.package] Attempting install of mutagen==1.42.0
2019-06-13 22:04:44 INFO (SyncWorker_19) [homeassistant.loader] Loaded google_translate from homeassistant.components.google_translate
2019-06-13 22:04:44 INFO (MainThread) [homeassistant.components.sensor] Setting up sensor.yr
2019-06-13 22:04:44 INFO (SyncWorker_14) [homeassistant.util.package] Attempting install of PyNaCl==1.3.0
2019-06-13 22:04:44 INFO (MainThread) [homeassistant.setup] Setting up tts
2019-06-13 22:04:44 INFO (SyncWorker_13) [homeassistant.components.tts] Create cache dir C:\Users\Corryn\AppData\Roaming.homeassistant\tts.
2019-06-13 22:04:46 INFO (MainThread) [homeassistant.setup] Setup of domain sensor took 12.0 seconds.
2019-06-13 22:04:47 INFO (MainThread) [homeassistant.setup] Setting up mobile_app
2019-06-13 22:04:47 INFO (MainThread) [homeassistant.setup] Setup of domain mobile_app took 0.0 seconds.
2019-06-13 22:04:47 INFO (SyncWorker_11) [homeassistant.util.package] Attempting install of hass-nabucasa==0.13
2019-06-13 22:04:47 INFO (SyncWorker_17) [homeassistant.loader] Loaded notify from homeassistant.components.notify
2019-06-13 22:04:47 INFO (MainThread) [homeassistant.setup] Setting up notify
2019-06-13 22:04:47 INFO (MainThread) [homeassistant.setup] Setup of domain notify took 0.0 seconds.
2019-06-13 22:04:47 INFO (MainThread) [homeassistant.components.notify] Setting up notify.mobile_app
2019-06-13 22:05:05 INFO (MainThread) [homeassistant.setup] Setting up cloud
2019-06-13 22:05:05 INFO (MainThread) [homeassistant.setup] Setting up zeroconf
2019-06-13 22:05:05 INFO (SyncWorker_2) [homeassistant.util.package] Attempting install of home-assistant-frontend==20190604.0
2019-06-13 22:05:05 INFO (MainThread) [homeassistant.setup] Setup of domain cloud took 0.4 seconds.
2019-06-13 22:05:06 INFO (MainThread) [homeassistant.setup] Setup of domain zeroconf took 0.8 seconds.
2019-06-13 22:05:45 INFO (MainThread) [homeassistant.setup] Setting up frontend
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Error during setup of component frontend
Traceback (most recent call last):
File “C:\Users\Corryn\AppData\Local\Programs\Python\Python37\lib\site-packages\homeassistant\setup.py”, line 153, in async_setup_component
hass, processed_config)
File "C:\Users\Corryn\AppData\Local\Programs\Python\Python37\lib\site-packages\homeassistant\components\frontend_init.py", line 217, in async_setup
root_path = frontend_root(repo_path)
File "C:\Users\Corryn\AppData\Local\Programs\Python\Python37\lib\site-packages\homeassistant\components\frontend_init.py", line 197, in _frontend_root
import hass_frontend
ModuleNotFoundError: No module named ‘hass_frontend’
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Unable to set up dependencies of map. Setup failed for dependencies: frontend
2019-06-13 22:05:45 INFO (SyncWorker_8) [homeassistant.util.package] Attempting install of gTTS-token==1.1.3
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Setup failed for map: Could not set up all dependencies.
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Unable to set up dependencies of logbook. Setup failed for dependencies: frontend
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Setup failed for logbook: Could not set up all dependencies.
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Unable to set up dependencies of default_config. Setup failed for dependencies: frontend, logbook, map, ssdp
2019-06-13 22:05:45 ERROR (MainThread) [homeassistant.setup] Setup failed for default_config: Could not set up all dependencies.
2019-06-13 22:05:47 INFO (MainThread) [homeassistant.setup] Setup of domain tts took 63.1 seconds.
2019-06-13 22:05:47 INFO (MainThread) [homeassistant.bootstrap] Home Assistant initialized in 89.12s
2019-06-13 22:05:47 INFO (MainThread) [homeassistant.core] Starting Home Assistant
2019-06-13 22:05:47 INFO (MainThread) [homeassistant.core] Timer:starting

anon34565116 · June 13, 2019, 1:19pm

If you are using Windows, I recommend setting up VirtualBox with a Debian or Ubuntu VM & bridged NIC.

Home Assistant is not supported at all on Windows although some have got it running.

I started out with a VirtualBox install before moving to a dedicated Raspberry Pi.

pnbruckner · June 13, 2019, 3:22pm

First, I’d agree, trying to run directly on Windows might be difficult at best. However, it looks like you didn’t install correctly in the first place. At the very least, if I were you, I’d start over and follow these instructions.

Also, unless you have some devices, automations, etc., set up, then typically you won’t see any messages after “Timer:starting”, unless you open the UI (i.e., open a browser at http://localhost:8123.) So, before you do anything else, try opening a browser.

pnbruckner · June 14, 2019, 1:13pm

FWIW, I just did a test based on another user’s topic on the same subject. Re-posting the details of what I did here:

- Install Python 3.7.3 for Windows
> py -m venv homeassistant
> cd homeassistant
> Scripts\activate
> py -m pip install --upgrade pip
> py -m pip install wheel
> py -m pip install homeassistant
> hass

EDIT: As a bonus, you can also add this step (after installing homeassistant):

pip install colorlog

Cheesenwine · June 15, 2019, 12:43am

Thanks both. OK considering I’m such a novice, I started over using the virtual machine with virtual box instead. It was reasonably simple as I have previous VM experience. Most difficult bit was getting the networking, IP and DHCP right. All good now.

@pnbruckner, I did try just browsing to the windows install it and indeed it is running. So the “–open-ui” parameter isn’t doing much. When I browse to it I see the home assistant UI but it’s quite different to all the other screenshots I 've seen. It seems to be missing some menu options and when I look at the logs it’s full of missing modules and timeout errors. When I get a chance I’ll go back and reinstall with your added commands. Thanks again.

Thanks all.