Fresh bench starting issue

OmarJaber · July 17, 2018, 8:20am

Hello,
I have install frappe using easy install and everything goes very well without any problems, after installing and run bench start it start then stop!
Any help

This is my what appears after bench start

root@aldaan:/home/frappe/frappe-bench# bench start
08:13:05 system           | redis_socketio.1 started (pid=24272)
08:13:05 system           | redis_queue.1 started (pid=24270)
08:13:05 system           | watch.1 started (pid=24269)
08:13:05 system           | worker_default.1 started (pid=24273)
08:13:05 system           | worker_long.1 started (pid=24268)
08:13:05 system           | web.1 started (pid=24277)
08:13:05 system           | schedule.1 started (pid=24271)
08:13:05 redis_queue.1    | 24279:M 17 Jul 08:13:05.070 * Increased maximum number of open files to 10032 (it was originally set to 1024).
08:13:05 redis_socketio.1 | 24278:M 17 Jul 08:13:05.071 * Increased maximum number of open files to 10032 (it was originally set to 1024).
08:13:05 redis_socketio.1 |                 _._                                                  
08:13:05 redis_socketio.1 |            _.-``__ ''-._                                             
08:13:05 redis_socketio.1 |       _.-``    `.  `_.  ''-._           Redis 3.0.6 (00000000/0) 64 bit
08:13:05 redis_socketio.1 |   .-`` .-```.  ```\/    _.,_ ''-._                                   
08:13:05 redis_socketio.1 |  (    '      ,       .-`  | `,    )     Running in standalone mode
08:13:05 redis_socketio.1 |  |`-._`-...-` __...-.``-._|'` _.-'|     Port: 12000
08:13:05 redis_socketio.1 |  |    `-._   `._    /     _.-'    |     PID: 24278
08:13:05 redis_socketio.1 |   `-._    `-._  `-./  _.-'    _.-'                                   
08:13:05 redis_socketio.1 |  |`-._`-._    `-.__.-'    _.-'_.-'|                                  
08:13:05 redis_socketio.1 |  |    `-._`-._        _.-'_.-'    |           http://redis.io        
08:13:05 redis_socketio.1 |   `-._    `-._`-.__.-'_.-'    _.-'                                   
08:13:05 redis_socketio.1 |  |`-._`-._    `-.__.-'    _.-'_.-'|                                  
08:13:05 redis_socketio.1 |  |    `-._`-._        _.-'_.-'    |                                  
08:13:05 redis_socketio.1 |   `-._    `-._`-.__.-'_.-'    _.-'                                   
08:13:05 redis_socketio.1 |       `-._    `-.__.-'    _.-'                                       
08:13:05 redis_socketio.1 |           `-._        _.-'                                           
08:13:05 redis_socketio.1 |               `-.__.-'                                               
08:13:05 redis_socketio.1 | 
08:13:05 system           | socketio.1 started (pid=24274)
08:13:05 redis_queue.1    |                 _._                                                  
08:13:05 redis_queue.1    |            _.-``__ ''-._                                             
08:13:05 redis_queue.1    |       _.-``    `.  `_.  ''-._           Redis 3.0.6 (00000000/0) 64 bit
08:13:05 redis_queue.1    |   .-`` .-```.  ```\/    _.,_ ''-._                                   
08:13:05 redis_queue.1    |  (    '      ,       .-`  | `,    )     Running in standalone mode
08:13:05 redis_queue.1    |  |`-._`-...-` __...-.``-._|'` _.-'|     Port: 11000
08:13:05 redis_queue.1    |  |    `-._   `._    /     _.-'    |     PID: 24279
08:13:05 redis_queue.1    |   `-._    `-._  `-./  _.-'    _.-'                                   
08:13:05 redis_queue.1    |  |`-._`-._    `-.__.-'    _.-'_.-'|                                  
08:13:05 redis_queue.1    |  |    `-._`-._        _.-'_.-'    |           http://redis.io        
08:13:05 redis_queue.1    |   `-._    `-._`-.__.-'_.-'    _.-'                                   
08:13:05 redis_queue.1    |  |`-._`-._    `-.__.-'    _.-'_.-'|                                  
08:13:05 redis_queue.1    |  |    `-._`-._        _.-'_.-'    |                                  
08:13:05 redis_queue.1    |   `-._    `-._`-.__.-'_.-'    _.-'                                   
08:13:05 redis_queue.1    |       `-._    `-.__.-'    _.-'                                       
08:13:05 redis_queue.1    |           `-._        _.-'                                           
08:13:05 redis_queue.1    |               `-.__.-'                                               
08:13:05 redis_queue.1    | 
08:13:05 redis_queue.1    | 24279:M 17 Jul 08:13:05.080 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128.
08:13:05 redis_queue.1    | 24279:M 17 Jul 08:13:05.080 # Server started, Redis version 3.0.6
08:13:05 redis_queue.1    | 24279:M 17 Jul 08:13:05.080 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
08:13:05 redis_queue.1    | 24279:M 17 Jul 08:13:05.080 # WARNING you have Transparent Huge Pages (THP) support enabled in your kernel. This will create latency and memory usage issues with Redis. To fix this issue run the command 'echo never > /sys/kernel/mm/transparent_hugepage/enabled' as root, and add it to your /etc/rc.local in order to retain the setting after a reboot. Redis must be restarted after THP is disabled.
08:13:05 redis_socketio.1 | 24278:M 17 Jul 08:13:05.082 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128.
08:13:05 redis_socketio.1 | 24278:M 17 Jul 08:13:05.082 # Server started, Redis version 3.0.6
08:13:05 redis_socketio.1 | 24278:M 17 Jul 08:13:05.082 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
08:13:05 redis_socketio.1 | 24278:M 17 Jul 08:13:05.082 # WARNING you have Transparent Huge Pages (THP) support enabled in your kernel. This will create latency and memory usage issues with Redis. To fix this issue run the command 'echo never > /sys/kernel/mm/transparent_hugepage/enabled' as root, and add it to your /etc/rc.local in order to retain the setting after a reboot. Redis must be restarted after THP is disabled.
08:13:05 redis_socketio.1 | 24278:M 17 Jul 08:13:05.083 * The server is now ready to accept connections on port 12000
08:13:05 system           | worker_short.1 started (pid=24292)
08:13:05 redis_queue.1    | 24279:M 17 Jul 08:13:05.085 * The server is now ready to accept connections on port 11000
08:13:05 system           | redis_cache.1 started (pid=24295)
08:13:05 redis_cache.1    | 24300:M 17 Jul 08:13:05.100 * Increased maximum number of open files to 10032 (it was originally set to 1024).
08:13:05 redis_cache.1    |                 _._                                                  
08:13:05 redis_cache.1    |            _.-``__ ''-._                                             
08:13:05 redis_cache.1    |       _.-``    `.  `_.  ''-._           Redis 3.0.6 (00000000/0) 64 bit
08:13:05 redis_cache.1    |   .-`` .-```.  ```\/    _.,_ ''-._                                   
08:13:05 redis_cache.1    |  (    '      ,       .-`  | `,    )     Running in standalone mode
08:13:05 redis_cache.1    |  |`-._`-...-` __...-.``-._|'` _.-'|     Port: 13000
08:13:05 redis_cache.1    |  |    `-._   `._    /     _.-'    |     PID: 24300
08:13:05 redis_cache.1    |   `-._    `-._  `-./  _.-'    _.-'                                   
08:13:05 redis_cache.1    |  |`-._`-._    `-.__.-'    _.-'_.-'|                                  
08:13:05 redis_cache.1    |  |    `-._`-._        _.-'_.-'    |           http://redis.io        
08:13:05 redis_cache.1    |   `-._    `-._`-.__.-'_.-'    _.-'                                   
08:13:05 redis_cache.1    |  |`-._`-._    `-.__.-'    _.-'_.-'|                                  
08:13:05 redis_cache.1    |  |    `-._`-._        _.-'_.-'    |                                  
08:13:05 redis_cache.1    |   `-._    `-._`-.__.-'_.-'    _.-'                                   
08:13:05 redis_cache.1    |       `-._    `-.__.-'    _.-'                                       
08:13:05 redis_cache.1    |           `-._        _.-'                                           
08:13:05 redis_cache.1    |               `-.__.-'                                               
08:13:05 redis_cache.1    | 
08:13:05 redis_cache.1    | 24300:M 17 Jul 08:13:05.113 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128.
08:13:05 redis_cache.1    | 24300:M 17 Jul 08:13:05.113 # Server started, Redis version 3.0.6
08:13:05 redis_cache.1    | 24300:M 17 Jul 08:13:05.113 # WARNING overcommit_memory is set to 0! Background save may fail under low memory condition. To fix this issue add 'vm.overcommit_memory = 1' to /etc/sysctl.conf and then reboot or run the command 'sysctl vm.overcommit_memory=1' for this to take effect.
08:13:05 redis_cache.1    | 24300:M 17 Jul 08:13:05.113 # WARNING you have Transparent Huge Pages (THP) support enabled in your kernel. This will create latency and memory usage issues with Redis. To fix this issue run the command 'echo never > /sys/kernel/mm/transparent_hugepage/enabled' as root, and add it to your /etc/rc.local in order to retain the setting after a reboot. Redis must be restarted after THP is disabled.
08:13:05 redis_cache.1    | 24300:M 17 Jul 08:13:05.113 * The server is now ready to accept connections on port 13000
08:13:07 socketio.1       | listening on *: 9000
08:13:17 web.1            |  * Running on http://0.0.0.0:8000/ (Press CTRL+C to quit)
08:13:17 web.1            |  * Restarting with inotify reloader
08:13:17 watch.1          | yarn run v1.7.0
08:13:17 watch.1          | $ node rollup/watch.js
08:13:18 web.1            |  * Debugger is active!
08:13:18 web.1            |  * Debugger PIN: 252-934-480
08:13:18 watch.1          | 
08:13:18 watch.1          | Rollup Watcher Started
08:13:18 watch.1          | 
08:13:18 watch.1          | Watching...
08:13:20 watch.1          | Rebuilding frappe-web.css
08:13:20 watch.1          | Rebuilding frappe-web.min.js
08:13:38 watch.1          | Rebuilding control.min.js
08:13:41 watch.1          | Rebuilding dialog.min.js
08:13:42 watch.1          | Rebuilding desk.min.css
08:13:42 watch.1          | Rebuilding frappe-rtl.css
08:13:42 watch.1          | Rebuilding desk.min.js
08:13:54 watch.1          | Killed
08:13:55 watch.1          | error Command failed with exit code 137.
08:13:55 watch.1          | info Visit https://yarnpkg.com/en/docs/cli/run for documentation about this command.
08:13:55 system           | watch.1 stopped (rc=0)
08:13:55 system           | sending SIGTERM to redis_socketio.1 (pid 24272)
08:13:55 system           | sending SIGTERM to worker_long.1 (pid 24268)
08:13:55 system           | sending SIGTERM to redis_queue.1 (pid 24270)
08:13:55 system           | sending SIGTERM to web.1 (pid 24277)
08:13:55 system           | sending SIGTERM to schedule.1 (pid 24271)
08:13:55 system           | sending SIGTERM to worker_default.1 (pid 24273)
08:13:55 system           | sending SIGTERM to socketio.1 (pid 24274)
08:13:55 system           | sending SIGTERM to redis_cache.1 (pid 24295)
08:13:55 system           | sending SIGTERM to worker_short.1 (pid 24292)
08:13:55 redis_socketio.1 | 24278:signal-handler (1531815235) Received SIGTERM scheduling shutdown...
08:13:55 redis_queue.1    | 24279:signal-handler (1531815235) Received SIGTERM scheduling shutdown...
08:13:55 worker_long.1    | 08:13:55 Warm shut down requested
08:13:55 worker_default.1 | 08:13:55 Warm shut down requested
08:13:55 system           | socketio.1 stopped (rc=-15)
08:13:55 redis_cache.1    | 24300:signal-handler (1531815235) Received SIGTERM scheduling shutdown...
08:13:55 worker_short.1   | 08:13:55 Warm shut down requested
08:13:55 system           | schedule.1 stopped (rc=-15)
08:13:55 redis_cache.1    | 24300:M 17 Jul 08:13:55.289 # User requested shutdown...
08:13:55 redis_cache.1    | 24300:M 17 Jul 08:13:55.289 # Redis is now ready to exit, bye bye...
08:13:55 redis_socketio.1 | 24278:M 17 Jul 08:13:55.290 # User requested shutdown...
08:13:55 redis_socketio.1 | 24278:M 17 Jul 08:13:55.290 # Redis is now ready to exit, bye bye...
08:13:55 redis_queue.1    | 24279:M 17 Jul 08:13:55.290 # User requested shutdown...
08:13:55 redis_queue.1    | 24279:M 17 Jul 08:13:55.290 # Redis is now ready to exit, bye bye...
08:13:55 system           | redis_queue.1 stopped (rc=-15)
08:13:55 system           | redis_socketio.1 stopped (rc=-15)
08:13:55 system           | redis_cache.1 stopped (rc=-15)
08:13:55 system           | worker_long.1 stopped (rc=-15)
08:13:55 system           | worker_default.1 stopped (rc=-15)
08:13:55 system           | worker_short.1 stopped (rc=-15)
08:13:55 system           | web.1 stopped (rc=-15)
root@aldaan:/home/frappe/frappe-bench#

magic-overflow · July 17, 2018, 8:35am

Someone said it’s caused by the memory limit of the machine.

alsum · July 17, 2018, 8:40am

try to kill all process that running on port 8000
that command will list them

lsof -i :8000

then start your bench again

OmarJaber · July 17, 2018, 8:49am

Thanks,I tried this but didn’t find any running process yet

OmarJaber · July 17, 2018, 8:51am

Thanks, I am too guess that this is the problem!
I will try again after increase the memory

alsum · July 17, 2018, 8:54am

okay try to restart redis server

service redis-server restart

if it doesn’t work try restart your development machine

mslake · July 17, 2018, 2:49pm

I have confirmed that I get a bench fail with 1gb but am successful with 2gb of ram in development mode. In production, 1GB seems to work.