You are viewing a plain text version of this content. The canonical link for it is here.
Posted to commits@airflow.apache.org by GitBox <gi...@apache.org> on 2021/02/02 14:59:05 UTC
[GitHub] [airflow] gdevanla opened a new issue #14034: Airflow Webserver slow to start up
gdevanla opened a new issue #14034:
URL: https://github.com/apache/airflow/issues/14034
<!--
Welcome to Apache Airflow! For a smooth issue process, try to answer the following questions.
Don't worry if they're not all applicable; just try to include what you can :-)
If you need to include code snippets or logs, please put them in fenced code
blocks. If they're super-long, please use the details tag like
<details><summary>super-long log</summary> lots of stuff </details>
Please delete these comment blocks before submitting the issue.
-->
<!--
IMPORTANT!!!
PLEASE CHECK "SIMILAR TO X EXISTING ISSUES" OPTION IF VISIBLE
NEXT TO "SUBMIT NEW ISSUE" BUTTON!!!
PLEASE CHECK IF THIS ISSUE HAS BEEN REPORTED PREVIOUSLY USING SEARCH!!!
Please complete the next sections or the issue will be closed.
These questions are the first thing we need to know to understand the context.
-->
**Apache Airflow version**:
2.0.0
**Kubernetes version (if you are using kubernetes)** (use `kubectl version`):
**Environment**:
- **Cloud provider or hardware configuration**:
- **OS** (e.g. from /etc/os-release): "18.04.1 LTS (Bionic Beaver)"
- **Kernel** (e.g. `uname -a`): 4.15.0-130-generic #134-Ubuntu
- **Install tools**:
- **Others**:
**What happened**:
I am observing real slow start up time when starting the webserver (compared to startup time from previous versions). With one workers, than start up time is close to 2 minutes.
Some observations, as I look at the logs (attached)
1. Registering routes seems to take ~25 seconds
2. Adding security decorators seems to take ~12 seconds
Then, I see this message:
```
[2021-02-02 06:36:45,875] {security.py:398} DEBUG - Cleaning faulty perms
Running the Gunicorn Server with:
Workers: 1 sync
Host: 0.0.0.0:8080
Timeout: 120
Logfiles: - -
Access Logformat:
=================================================================
[2021-02-02 06:36:46,059] {cli_action_loggers.py:84} DEBUG - Calling callbacks: []
[2021-02-02 06:36:46,063] {settings.py:290} DEBUG - Disposing DB connection pool (PID 24448)
[2021-02-02 06:36:46,487] {settings.py:208} DEBUG - Setting up DB connection pool (PID 24684)
[2021-02-02 06:36:46,487] {settings.py:273} DEBUG - settings.prepare_engine_args(): Using pool settings. pool_size=5, max_overflow=10, pool_recycle=1800, pid=24684
```
3. After that, the `Registering route` routines kickin for the second time and the entire process repeats once more.
So, effectively, we are re-running all startup related process twice.
**What you expected to happen**:
Could be useful if we could speed this up. Helps in iterative development of plugins.
I think I may be missing some `timeout` value, which is causing the process to recycle in a minute.
**How to reproduce it**:
airflow_webserver -w 1
As minimally and precisely as possible. Keep in mind we do not have access to your cluster or dags.
If you are using kubernetes, please attempt to recreate the issue using minikube or kind.
## Install minikube/kind
- Minikube https://minikube.sigs.k8s.io/docs/start/
- Kind https://kind.sigs.k8s.io/docs/user/quick-start/
If this is a UI bug, please provide a screenshot of the bug or a link to a youtube video of the bug in action
You can include images using the .md style of
To record a screencast, mac users can use QuickTime and then create an unlisted youtube video with the resulting .mov file.
--->
**Anything else we need to know**:
<!--
How often does this problem occur? Once? Every time etc?
Any relevant logs to include? Put them here in side a detail tag:
<details><summary>x.log</summary> lots of stuff </details>
-->
[airflow_web_non_debug.log](https://github.com/apache/airflow/files/5912041/airflow_web_non_debug.log)
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] zachliu commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
zachliu commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771954592
i had to do
```shell
time docker run --rm <IMAGE_NAME> bash -c "airflow db init && EXECUTOR=Sequential AIRFLOW__LOGGING__LOGGING_LEVEL=debug FLASK_APP=airflow.www.app:create_app flask routes"
```
i got
```shell
0.07s user 0.08s system 0% cpu 21.182 total
```
but this doesn't mimic our production environment which uses the CeleryExecutor
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] i2gor87 commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
i2gor87 commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-809869853
My output of command on airflow 2.0.1, docker-compose.yml from airflow docs:
My webserver isn't starting at all, constantly spamming `[CRITICAL] WORKER TIMEOUT (pid:364)`
Server stats:
```
CPU utilization ~19.8% (AWS monitor)
Memory consumption 2.17G/3.81G (htop)
```
`time docker-compose run {CONTAINER_NAME} bash -c "AIRFLOW__LOGGING__LOGGING_LEVEL=debug FLASK_APP=airflow.www.app:create_app flask routes"`
On new container(docker-compose run airflow-worker)
```
real 5m30.802s
user 0m1.193s
sys 0m0.259s
```
On existing container:
```
real 13m23.415s
user 0m1.095s
sys 0m0.217s
```
--
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] ashb commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
ashb commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-810229944
This should have been fixed by @jedcunningham's latest PRs #14993 and #15017 (included in what will become 2.0.2), so I'm going to close for now.
--
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] mik-laj commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
mik-laj commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771915219
If you are using Docker, you can check it with this command.
```
time docker run -rm <IMAGE_NAME> bash -c "AIRFLOW__LOGGING__LOGGING_LEVEL=debug FLASK_APP=airflow.www.app:create_app flask routes"
```
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] gdevanla commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
gdevanla commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771930785
This is what I get:
```
bash -c 8.49s user 1.89s system 10% cpu 1:41.12 total
```
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] mik-laj commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
mik-laj commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771896965
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] zachliu commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
zachliu commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771891980
i noticed the same issue on airflow 2.0.0, and i have 4 worker processes for the webserver
```
# Number of workers to run the Gunicorn web server
workers = 4
```
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] zachliu commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
zachliu commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771891980
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] ashb closed issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
ashb closed issue #14034:
URL: https://github.com/apache/airflow/issues/14034
--
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] mik-laj commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
mik-laj commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771896965
Can you check how long it takes to display all routes?
```
time bash -c "AIRFLOW__LOGGING__LOGGING_LEVEL=debug FLASK_APP=airflow.www.app:create_app flask routes"
```
For me:
```
real 0m16.187s
user 0m8.826s
sys 0m0.973s
```
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] zachliu commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
zachliu commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771913216
where should i insert this line in my `entrypoint.sh`? i suppose right after
```shell
exec airflow webserver
```
?
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] potiuk commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
potiuk commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771888044
@mik-laj -> that looks like registration of API routes and security decorators. It look that if takes > 2 minutes to start the whole process indeed seems to restar. I cannot see though why It's so slow. I think this might be caused by some network configuration executing some roundtrip network operation with every route adding ? This certainly looks like it and maybe we can somewhat prevent it from happening
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] gdevanla commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
gdevanla commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771930785
This is what I get:
```
bash -c 8.49s user 1.89s system 10% cpu 1:41.12 total
```
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org
[GitHub] [airflow] potiuk commented on issue #14034: Airflow Webserver slow to start up
Posted by GitBox <gi...@apache.org>.
potiuk commented on issue #14034:
URL: https://github.com/apache/airflow/issues/14034#issuecomment-771888044
@mik-laj -> that looks like registration of API routes and security decorators. It look that if takes > 2 minutes to start the whole process indeed seems to restar. I cannot see though why It's so slow. I think this might be caused by some network configuration executing some roundtrip network operation with every route adding ? This certainly looks like it and maybe we can somewhat prevent it from happening
----------------------------------------------------------------
This is an automated message from the Apache Git Service.
To respond to the message, please log on to GitHub and use the
URL above to go to the specific comment.
For queries about this service, please contact Infrastructure at:
users@infra.apache.org