Dear Team,
I am trying to install ERP Next on AWS instance.
Getting packet_write_wait: Connection to x.x.x.x port 22: Broken pipe message after bench start command.
bench@ip-172-31-34-145:~/erpnext$ bench start
09:16:17 system | watch.1 started (pid=2139)
09:16:17 system | redis_queue.1 started (pid=2140)
09:16:17 system | web.1 started (pid=2141)
09:16:17 system | redis_socketio.1 started (pid=2142)
09:16:17 system | schedule.1 started (pid=2143)
09:16:17 system | worker_long.1 started (pid=2138)
09:16:17 system | socketio.1 started (pid=2144)
09:16:17 system | redis_cache.1 started (pid=2146)
09:16:17 system | worker_default.1 started (pid=2145)
09:16:17 redis_queue.1 | 2149:C 12 Jul 09:16:17.299 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
09:16:17 redis_queue.1 | 2149:C 12 Jul 09:16:17.299 # Redis version=4.0.9, bits=64, commit=00000000, modified=0, pid=2149, just started
09:16:17 redis_queue.1 | 2149:C 12 Jul 09:16:17.299 # Configuration loaded
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.302 * Increased maximum number of open files to 10032 (it was originally set to 1024).
09:16:17 system | worker_short.1 started (pid=2147)
09:16:17 redis_socketio.1 | 2165:C 12 Jul 09:16:17.309 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
09:16:17 redis_socketio.1 | 2165:C 12 Jul 09:16:17.309 # Redis version=4.0.9, bits=64, commit=00000000, modified=0, pid=2165, just started
09:16:17 redis_socketio.1 | 2165:C 12 Jul 09:16:17.309 # Configuration loaded
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.310 * Increased maximum number of open files to 10032 (it was originally set to 1024).
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.311 * Running mode=standalone, port=11000.
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.311 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128.
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.311 # Server initialized
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.311 # 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.
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.312 # 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.
09:16:17 redis_cache.1 | 2161:C 12 Jul 09:16:17.316 # oO0OoO0OoO0Oo Redis is starting oO0OoO0OoO0Oo
09:16:17 redis_cache.1 | 2161:C 12 Jul 09:16:17.316 # Redis version=4.0.9, bits=64, commit=00000000, modified=0, pid=2161, just started
09:16:17 redis_cache.1 | 2161:C 12 Jul 09:16:17.316 # Configuration loaded
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.317 * Increased maximum number of open files to 10032 (it was originally set to 1024).
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.318 * Running mode=standalone, port=12000.
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.318 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128.
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.319 # Server initialized
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.319 # 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.
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.319 # 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.
09:16:17 redis_socketio.1 | 2165:M 12 Jul 09:16:17.319 * Ready to accept connections
09:16:17 redis_queue.1 | 2149:M 12 Jul 09:16:17.320 * Ready to accept connections
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.327 * Running mode=standalone, port=13000.
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.327 # WARNING: The TCP backlog setting of 511 cannot be enforced because /proc/sys/net/core/somaxconn is set to the lower value of 128.
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.327 # Server initialized
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.331 # 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.
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.332 # 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.
09:16:17 redis_cache.1 | 2161:M 12 Jul 09:16:17.332 * Ready to accept connections
09:16:19 socketio.1 | listening on *: 9000
09:16:28 web.1 | * Running on http://0.0.0.0:8000/ (Press CTRL+C to quit)
09:16:28 web.1 | * Restarting with inotify reloader
09:16:29 watch.1 | yarn run v1.16.0
09:16:29 watch.1 | $ node rollup/watch.js
09:16:30 web.1 | * Debugger is active!
09:16:30 web.1 | * Debugger PIN: 135-785-015
09:16:32 watch.1 |
09:16:32 watch.1 | Rollup Watcher Started
09:16:32 watch.1 |
09:16:32 watch.1 | Watching...
09:16:33 watch.1 | Rebuilding frappe-web.css
09:16:35 watch.1 | Rebuilding frappe-web-b4.css
09:16:35 watch.1 | Rebuilding chat.js
09:16:37 watch.1 | Rebuilding frappe-recorder.min.js
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET / HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET / HTTP/1.1" 200 -
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/css/frappe-web-b4.css HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/css/frappe-web-b4.css HTTP/1.1" 200 -
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/css/erpnext-web.css HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/css/erpnext-web.css HTTP/1.1" 200 -
09:16:42 watch.1 | Rebuilding frappe-web.min.js
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/js/frappe-web.min.js HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/js/frappe-web.min.js HTTP/1.1" 200 -
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/frappe/js/lib/jquery/jquery.min.js HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/frappe/js/lib/jquery/jquery.min.js HTTP/1.1" 200 -
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/js/bootstrap-4-web.min.js HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/js/bootstrap-4-web.min.js HTTP/1.1" 200 -
09:16:42 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/js/erpnext-web.min.js HTTP/1.1" 200 -
09:16:42 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:42] "GET /assets/js/erpnext-web.min.js HTTP/1.1" 200 -
09:16:43 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:43] "GET /website_script.js HTTP/1.1" 200 -
09:16:43 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:43] "GET /website_script.js HTTP/1.1" 200 -
09:16:44 watch.1 | Rebuilding bootstrap-4-web.min.js
09:16:46 watch.1 | Rebuilding control.min.js
09:16:48 watch.1 | Rebuilding dialog.min.js
09:16:50 watch.1 | Rebuilding desk.min.css
09:16:50 watch.1 | Rebuilding frappe-rtl.css
09:16:50 watch.1 | Rebuilding printview.css
09:16:50 watch.1 | Rebuilding desk.min.js
09:16:54 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:54] "GET /assets/frappe/css/fonts/fontawesome/fontawesome-webfont.woff2?v=4.7.0 HTTP/1.1" 200 -
09:16:54 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:54] "GET /assets/frappe/css/fonts/fontawesome/fontawesome-webfont.woff2?v=4.7.0 HTTP/1.1" 200 -
09:16:54 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:54] "GET /assets/erpnext/images/favicon.png HTTP/1.1" 200 -
09:16:54 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:54] "GET /assets/erpnext/images/favicon.png HTTP/1.1" 200 -
09:16:54 web.1 | 122.172.128.228 - - [12/Jul/2019 09:16:54] "POST / HTTP/1.1" 200 -
09:16:54 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:16:54] "POST / HTTP/1.1" 200 -
09:16:56 watch.1 | Rebuilding module.min.css
09:16:56 watch.1 | Rebuilding form.min.css
09:16:56 watch.1 | Rebuilding form.min.js
09:17:00 watch.1 | Rebuilding list.min.css
09:17:00 watch.1 | Rebuilding list.min.js
09:17:07 watch.1 | Rebuilding report.min.css
09:17:07 watch.1 | Rebuilding report.min.js
09:17:10 watch.1 | Rebuilding web_form.min.js
09:17:11 watch.1 | Rebuilding web_form.css
09:17:11 watch.1 | Rebuilding email.css
09:17:11 watch.1 | Rebuilding social.min.js
09:17:15 watch.1 | Rebuilding modules.min.js
09:17:17 watch.1 | Rebuilding erpnext.css
09:17:18 watch.1 | Rebuilding marketplace.css
09:17:18 watch.1 | Rebuilding erpnext-web.min.js
09:17:19 watch.1 | Rebuilding erpnext-web.css
09:17:19 watch.1 | Rebuilding marketplace.min.js
09:17:24 web.1 | 122.172.128.228 - - [12/Jul/2019 09:17:24] "POST / HTTP/1.1" 200 -
09:17:24 web.1 | INFO:werkzeug:122.172.128.228 - - [12/Jul/2019 09:17:24] "POST / HTTP/1.1" 200 -
09:19:05 schedule.1 | Traceback (most recent call last):
09:19:11 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/utils/scheduler.py", line 69, in enqueue_events_for_all_sites
09:19:12 schedule.1 | enqueue_events_for_site(site=site, queued_jobs=jobs_per_site[site])
09:19:13 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/utils/scheduler.py", line 99, in enqueue_events_for_site
09:19:17 schedule.1 | log_and_raise()
09:19:18 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/utils/scheduler.py", line 89, in enqueue_events_for_site
09:19:18 schedule.1 | if is_scheduler_disabled():
09:19:20 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/utils/scheduler.py", line 233, in is_scheduler_disabled
09:19:24 schedule.1 | return not frappe.utils.cint(frappe.db.get_single_value("System Settings", "enable_scheduler"))
09:19:29 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/database/database.py", line 552, in get_single_value
09:19:32 schedule.1 | `tabSingles` where `doctype`=%s and `field`=%s""", (doctype, fieldname))
09:19:34 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/database/database.py", line 122, in sql
09:19:37 schedule.1 | self.connect()
09:19:40 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/database/database.py", line 75, in connect
09:19:43 schedule.1 | self._conn = self.get_connection()
09:19:49 schedule.1 | File "/opt/bench/erpnext/apps/frappe/frappe/database/mariadb/database.py", line 90, in get_connection
09:19:51 schedule.1 | local_infile = frappe.conf.local_infile)
09:20:01 schedule.1 | File "/opt/bench/erpnext/env/local/lib/python2.7/site-packages/pymysql/__init__.py", line 94, in Connect
09:20:04 schedule.1 | return Connection(*args, **kwargs)
09:20:07 schedule.1 | File "/opt/bench/erpnext/env/local/lib/python2.7/site-packages/pymysql/connections.py", line 325, in __init__
09:20:11 schedule.1 | self.connect()
09:20:25 schedule.1 | File "/opt/bench/erpnext/env/local/lib/python2.7/site-packages/pymysql/connections.py", line 599, in connect
09:20:39 schedule.1 | self._request_authentication()
09:20:40 schedule.1 | File "/opt/bench/erpnext/env/local/lib/python2.7/site-packages/pymysql/connections.py", line 861, in _request_authentication
09:20:46 schedule.1 | auth_packet = self._read_packet()
09:20:54 schedule.1 | File "/opt/bench/erpnext/env/local/lib/python2.7/site-packages/pymysql/connections.py", line 657, in _read_packet
09:20:56 schedule.1 | packet_header = self._read_bytes(4)
09:21:11 schedule.1 | File "/opt/bench/erpnext/env/local/lib/python2.7/site-packages/pymysql/connections.py", line 707, in _read_bytes
09:21:16 schedule.1 | CR.CR_SERVER_LOST, "Lost connection to MySQL server during query")
09:21:27 schedule.1 | OperationalError: (2013, 'Lost connection to MySQL server during query')
09:21:31 schedule.1 |
packet_write_wait: Connection to 18.191.127.197 port 22: Broken pipe