root@appscale-image0:/var/log/appscale# tail -f controller-17443.log W, [2016-12-01T10:01:16.540843 #31755] WARN -- : [is_port_open](104.131.100.138 , 2181): got Connection refused - connect(2). W, [2016-12-01T10:01:17.542026 #31755] WARN -- : [is_port_open](104.131.100.138 , 2181): got Connection refused - connect(2). I, [2016-12-01T10:01:18.383858 #31755] INFO -- : Starting zookeeper on port 218 1 with start command [/usr/sbin/service zookeeper-server start] and stop command [/usr/sbin/service zookeeper-server stop] I, [2016-12-01T10:01:18.406133 #31755] INFO -- : Done configuring zookeeper. I, [2016-12-01T10:01:18.649048 #31755] INFO -- : Set custom cassandra configura tion. I, [2016-12-01T10:01:19.367517 #31755] INFO -- : Waiting for DB services ... I, [2016-12-01T10:01:19.367871 #31755] INFO -- : Starting database services. I, [2016-12-01T10:01:19.368280 #31755] INFO -- : Starting up Cassandra seed nod e I, [2016-12-01T10:01:21.407761 #31755] INFO -- : Starting cassandra on port 999 9 with start command [su -c "/opt/cassandra/cassandra/bin/cassandra -p /tmp/apps cale-cassandra.pid" cassandra] and stop command [/bin/bash -c 'kill $(cat /tmp/a ppscale-cassandra.pid)'] I, [2016-12-01T10:01:21.459136 #31755] INFO -- : Waiting for Cassandra to start ^C root@appscale-image0:/var/log/appscale# ls -lrt total 17244 -rw-r--r-- 1 root root 10671385 Dec 1 06:17 cassandra-9999.log.1 -rw-r--r-- 1 root root 154495 Dec 1 10:01 iaas_manager-17444.log -rw-r--r-- 1 root root 501 Dec 1 10:01 haproxy-9999.log -rw-r--r-- 1 root root 288 Dec 1 10:01 zookeeper-2181.log -rw-r--r-- 1 root root 16286 Dec 1 10:01 controller-17443.log -rw-r--r-- 1 root root 6792840 Dec 1 10:02 cassandra-9999.log root@appscale-image0:/var/log/appscale# cat controller-17443.log I, [2016-12-01T00:47:09.729634 #3651] INFO -- : ==== Starting AppController (pid: 3651) ==== I, [2016-12-01T00:47:11.736866 #3651] INFO -- : Starting iaas_manager on port 17444 with start command [/usr/bin/python2 /root/appscale/InfrastructureManager/infrastructure_manager_service.py] and stop command [/usr/bin/python2 /root/appscale/scripts/stop_service.py /root/appscale/InfrastructureManager/infrastructure_manager_service.py /usr/bin/python2] I, [2016-12-01T00:47:11.762846 #3651] INFO -- : Started InfrastructureManager successfully! I, [2016-12-01T00:47:11.763029 #3651] INFO -- : /etc/appscale/zookeeper_locations.json doesn't exist: not restoring data. I, [2016-12-01T00:47:11.766231 #3651] INFO -- : Reloading nginx service. E, [2016-12-01T00:47:12.727898 #3651] ERROR -- DjinnServer: OpenSSL::SSL::SSLError: SSL_accept SYSCALL returned=5 errno=0 state=unknown state /usr/lib/ruby/1.9.1/openssl/ssl-internal.rb:172:in `accept' I, [2016-12-01T00:47:11.790792 #3651] INFO -- : Waiting for data from the load balancer or cmdline tools I, [2016-12-01T00:47:13.054182 #3651] INFO -- : Converting 'verbose' with value 'False'. I, [2016-12-01T00:47:13.054344 #3651] INFO -- : Converting 'replication' with value 'None'. W, [2016-12-01T00:47:13.054601 #3651] WARN -- : Warning: parameter 'replication' is not an integer (None). Removing it. I, [2016-12-01T00:47:13.054679 #3651] INFO -- : Converting 'table' with value 'cassandra'. I, [2016-12-01T00:47:13.054771 #3651] INFO -- : Converting 'user_commands' with value '[]'. I, [2016-12-01T00:47:13.054832 #3651] INFO -- : Converting 'autoscale' with value 'True'. I, [2016-12-01T00:47:13.054888 #3651] INFO -- : Converting 'flower_password' with value 'appscale'. I, [2016-12-01T00:47:13.054943 #3651] INFO -- : Converting 'max_memory' with value '400'. I, [2016-12-01T00:47:13.055042 #3651] INFO -- : Converting 'clear_datastore' with value 'False'. I, [2016-12-01T00:47:13.055127 #3651] INFO -- : Converting 'keyname' with value 'appscale3b9cd48c275441debcd0b73e722e9152'. I, [2016-12-01T00:47:13.055189 #3651] INFO -- : Converting 'login' with value '104.131.100.138'. I, [2016-12-01T00:47:13.055266 #3651] INFO -- : Converting 'appengine' with value '1'. W, [2016-12-01T00:47:13.055397 #3651] WARN -- : max_images is less than the number of nodes! Unknown option: -C usage: git [--version] [--exec-path[=]] [--html-path] [--man-path] [--info-path] [-p|--paginate|--no-pager] [--no-replace-objects] [--bare] [--git-dir=] [--work-tree=] [--namespace=] [-c name=value] [--help] [] I, [2016-12-01T00:47:16.942399 #3651] INFO -- : Preparing other nodes for this deployment. I, [2016-12-01T00:47:16.997915 #3651] INFO -- : Done initializing nodes. I, [2016-12-01T00:47:19.049922 #3651] INFO -- : Starting haproxy on port 9999 with start command [/usr/sbin/service haproxy start] and stop command [/usr/sbin/service haproxy stop] I, [2016-12-01T00:47:19.071491 #3651] INFO -- : HAProxy configured and started. I, [2016-12-01T00:47:22.134070 #3651] INFO -- : Starting nginx on port 9999 with start command [/usr/bin/service nginx start] and stop command [/usr/bin/service nginx stop] I, [2016-12-01T00:47:22.158129 #3651] INFO -- : Nginx configured and started. I, [2016-12-01T00:47:22.192140 #3651] INFO -- : Reloading nginx service. I, [2016-12-01T00:47:22.234531 #3651] INFO -- : Reloading nginx service. I, [2016-12-01T00:47:22.273361 #3651] INFO -- : Only saw one machine, therefore my node is also a slave node I, [2016-12-01T00:47:22.302253 #3651] INFO -- : Starting API Services. I, [2016-12-01T00:47:22.302532 #3651] INFO -- : Trying to use zookeeper server at 104.131.100.138. W, [2016-12-01T00:47:22.304424 #3651] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). sed: can't read /etc/zookeeper/conf/environment: No such file or directory I, [2016-12-01T00:47:22.335080 #3651] INFO -- : Starting zookeeper. W, [2016-12-01T00:47:23.306695 #3651] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). I, [2016-12-01T00:47:23.366218 #3651] INFO -- : Initializing ZooKeeper. No myid provided, be sure to specify it in /opt/appscale/zookeeper/myid if using non-standalone W, [2016-12-01T00:47:24.307487 #3651] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). W, [2016-12-01T00:47:25.308263 #3651] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). I, [2016-12-01T00:47:25.650208 #3651] INFO -- : Starting zookeeper on port 2181 with start command [/usr/sbin/service zookeeper-server start] and stop command [/usr/sbin/service zookeeper-server stop] I, [2016-12-01T00:47:25.674967 #3651] INFO -- : Done configuring zookeeper. I, [2016-12-01T00:47:26.389520 #3651] INFO -- : Set custom cassandra configuration. I, [2016-12-01T00:47:27.533324 #3651] INFO -- : Waiting for DB services ... I, [2016-12-01T00:47:27.533588 #3651] INFO -- : Starting database services. I, [2016-12-01T00:47:27.533795 #3651] INFO -- : Starting up Cassandra seed node I, [2016-12-01T00:47:29.548366 #3651] INFO -- : Starting cassandra on port 9999 with start command [su -c "/opt/cassandra/cassandra/bin/cassandra -p /tmp/appscale-cassandra.pid" cassandra] and stop command [/bin/bash -c 'kill $(cat /tmp/appscale-cassandra.pid)'] I, [2016-12-01T00:47:29.598904 #3651] INFO -- : Waiting for Cassandra to start I, [2016-12-01T00:56:52.590642 #15306] INFO -- : ==== Starting AppController (pid: 15306) ==== E, [2016-12-01T00:56:53.014984 #15306] ERROR -- DjinnServer: OpenSSL::SSL::SSLError: SSL_accept SYSCALL returned=5 errno=0 state=unknown state /usr/lib/ruby/1.9.1/openssl/ssl-internal.rb:172:in `accept' I, [2016-12-01T00:56:53.342909 #15306] INFO -- : Converting 'verbose' with value 'False'. I, [2016-12-01T00:56:53.343043 #15306] INFO -- : Converting 'replication' with value 'None'. W, [2016-12-01T00:56:53.343157 #15306] WARN -- : Warning: parameter 'replication' is not an integer (None). Removing it. I, [2016-12-01T00:56:53.343217 #15306] INFO -- : Converting 'table' with value 'cassandra'. I, [2016-12-01T00:56:53.343261 #15306] INFO -- : Converting 'user_commands' with value '[]'. I, [2016-12-01T00:56:53.343297 #15306] INFO -- : Converting 'autoscale' with value 'True'. I, [2016-12-01T00:56:53.343332 #15306] INFO -- : Converting 'flower_password' with value 'appscale'. I, [2016-12-01T00:56:53.343387 #15306] INFO -- : Converting 'max_memory' with value '400'. I, [2016-12-01T00:56:53.343430 #15306] INFO -- : Converting 'clear_datastore' with value 'False'. I, [2016-12-01T00:56:53.343479 #15306] INFO -- : Converting 'keyname' with value 'appscale3b9cd48c275441debcd0b73e722e9152'. I, [2016-12-01T00:56:53.343516 #15306] INFO -- : Converting 'login' with value '104.131.100.138'. I, [2016-12-01T00:56:53.343565 #15306] INFO -- : Converting 'appengine' with value '1'. W, [2016-12-01T00:56:53.343637 #15306] WARN -- : max_images is less than the number of nodes! I, [2016-12-01T00:56:54.597834 #15306] INFO -- : Starting iaas_manager on port 17444 with start command [/usr/bin/python2 /root/appscale/InfrastructureManager/infrastructure_manager_service.py] and stop command [/usr/bin/python2 /root/appscale/scripts/stop_service.py /root/appscale/InfrastructureManager/infrastructure_manager_service.py /usr/bin/python2] I, [2016-12-01T00:56:54.618940 #15306] INFO -- : Started InfrastructureManager successfully! I, [2016-12-01T00:56:54.619155 #15306] INFO -- : /etc/appscale/zookeeper_locations.json doesn't exist: not restoring data. I, [2016-12-01T00:56:54.623411 #15306] INFO -- : Reloading nginx service. cat: /var/run/haproxy.pid: No such file or directory [ALERT] 335/005654 (15371) : config : no line. Nothing to do ! [ALERT] 335/005654 (15371) : Fatal errors found in configuration. Unknown option: -C usage: git [--version] [--exec-path[=]] [--html-path] [--man-path] [--info-path] [-p|--paginate|--no-pager] [--no-replace-objects] [--bare] [--git-dir=] [--work-tree=] [--namespace=] [-c name=value] [--help] [] I, [2016-12-01T00:56:54.681906 #15306] INFO -- : Preparing other nodes for this deployment. I, [2016-12-01T00:56:54.708573 #15306] INFO -- : Done initializing nodes. I, [2016-12-01T00:56:56.734056 #15306] INFO -- : Starting haproxy on port 9999 with start command [/usr/sbin/service haproxy start] and stop command [/usr/sbin/service haproxy stop] I, [2016-12-01T00:56:56.762290 #15306] INFO -- : HAProxy configured and started. I, [2016-12-01T00:56:59.854871 #15306] INFO -- : Starting nginx on port 9999 with start command [/usr/bin/service nginx start] and stop command [/usr/bin/service nginx stop] monit: action failed -- There is no service by that name I, [2016-12-01T00:56:59.885839 #15306] INFO -- : Nginx configured and started. cat: /var/run/haproxy.pid: No such file or directory I, [2016-12-01T00:56:59.928083 #15306] INFO -- : Reloading nginx service. I, [2016-12-01T00:56:59.973445 #15306] INFO -- : Reloading nginx service. I, [2016-12-01T00:57:00.013816 #15306] INFO -- : Only saw one machine, therefore my node is also a slave node I, [2016-12-01T00:57:00.041524 #15306] INFO -- : Starting API Services. I, [2016-12-01T00:57:00.041711 #15306] INFO -- : Trying to use zookeeper server at 104.131.100.138. W, [2016-12-01T00:57:00.042188 #15306] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). sed: can't read /etc/zookeeper/conf/environment: No such file or directory I, [2016-12-01T00:57:00.079210 #15306] INFO -- : Starting zookeeper. W, [2016-12-01T00:57:01.043047 #15306] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). I, [2016-12-01T00:57:02.098413 #15306] INFO -- : Set custom cassandra configuration. I, [2016-12-01T00:57:02.628194 #15306] INFO -- : Starting zookeeper on port 2181 with start command [/usr/sbin/service zookeeper-server start] and stop command [/usr/sbin/service zookeeper-server stop] I, [2016-12-01T00:57:02.678764 #15306] INFO -- : Done configuring zookeeper. I, [2016-12-01T00:57:02.775449 #15306] INFO -- : Waiting for DB services ... I, [2016-12-01T00:57:02.775677 #15306] INFO -- : Starting database services. I, [2016-12-01T00:57:02.776015 #15306] INFO -- : Starting up Cassandra seed node I, [2016-12-01T00:57:04.790319 #15306] INFO -- : Starting cassandra on port 9999 with start command [su -c "/opt/cassandra/cassandra/bin/cassandra -p /tmp/appscale-cassandra.pid" cassandra] and stop command [/bin/bash -c 'kill $(cat /tmp/appscale-cassandra.pid)'] I, [2016-12-01T00:57:04.866100 #15306] INFO -- : Waiting for Cassandra to start I, [2016-12-01T10:01:08.006841 #31755] INFO -- : ==== Starting AppController (pid: 31755) ==== E, [2016-12-01T10:01:08.289950 #31755] ERROR -- DjinnServer: OpenSSL::SSL::SSLError: SSL_accept SYSCALL returned=5 errno=0 state=unknown state /usr/lib/ruby/1.9.1/openssl/ssl-internal.rb:172:in `accept' I, [2016-12-01T10:01:08.599419 #31755] INFO -- : Converting 'verbose' with value 'False'. I, [2016-12-01T10:01:08.599525 #31755] INFO -- : Converting 'replication' with value 'None'. W, [2016-12-01T10:01:08.599637 #31755] WARN -- : Warning: parameter 'replication' is not an integer (None). Removing it. I, [2016-12-01T10:01:08.599695 #31755] INFO -- : Converting 'table' with value 'cassandra'. I, [2016-12-01T10:01:08.599740 #31755] INFO -- : Converting 'user_commands' with value '[]'. I, [2016-12-01T10:01:08.599776 #31755] INFO -- : Converting 'autoscale' with value 'True'. I, [2016-12-01T10:01:08.599810 #31755] INFO -- : Converting 'flower_password' with value 'appscale'. I, [2016-12-01T10:01:08.599866 #31755] INFO -- : Converting 'max_memory' with value '400'. I, [2016-12-01T10:01:08.599908 #31755] INFO -- : Converting 'clear_datastore' with value 'False'. I, [2016-12-01T10:01:08.599955 #31755] INFO -- : Converting 'keyname' with value 'appscale3b9cd48c275441debcd0b73e722e9152'. I, [2016-12-01T10:01:08.599988 #31755] INFO -- : Converting 'login' with value '104.131.100.138'. I, [2016-12-01T10:01:08.600038 #31755] INFO -- : Converting 'appengine' with value '1'. W, [2016-12-01T10:01:08.600143 #31755] WARN -- : max_images is less than the number of nodes! I, [2016-12-01T10:01:10.013418 #31755] INFO -- : Starting iaas_manager on port 17444 with start command [/usr/bin/python2 /root/appscale/InfrastructureManager/infrastructure_manager_service.py] and stop command [/usr/bin/python2 /root/appscale/scripts/stop_service.py /root/appscale/InfrastructureManager/infrastructure_manager_service.py /usr/bin/python2] I, [2016-12-01T10:01:10.034766 #31755] INFO -- : Started InfrastructureManager successfully! I, [2016-12-01T10:01:10.034919 #31755] INFO -- : /etc/appscale/zookeeper_locations.json doesn't exist: not restoring data. I, [2016-12-01T10:01:10.039218 #31755] INFO -- : Reloading nginx service. cat: /var/run/haproxy.pid: No such file or directory [ALERT] 335/100110 (31820) : config : no line. Nothing to do ! [ALERT] 335/100110 (31820) : Fatal errors found in configuration. Unknown option: -C usage: git [--version] [--exec-path[=]] [--html-path] [--man-path] [--info-path] [-p|--paginate|--no-pager] [--no-replace-objects] [--bare] [--git-dir=] [--work-tree=] [--namespace=] [-c name=value] [--help] [] I, [2016-12-01T10:01:10.107396 #31755] INFO -- : Preparing other nodes for this deployment. I, [2016-12-01T10:01:10.135027 #31755] INFO -- : Done initializing nodes. I, [2016-12-01T10:01:12.167673 #31755] INFO -- : Starting haproxy on port 9999 with start command [/usr/sbin/service haproxy start] and stop command [/usr/sbin/service haproxy stop] I, [2016-12-01T10:01:12.200630 #31755] INFO -- : HAProxy configured and started. I, [2016-12-01T10:01:15.308805 #31755] INFO -- : Starting nginx on port 9999 with start command [/usr/bin/service nginx start] and stop command [/usr/bin/service nginx stop] monit: action failed -- There is no service by that name I, [2016-12-01T10:01:15.341510 #31755] INFO -- : Nginx configured and started. cat: /var/run/haproxy.pid: No such file or directory I, [2016-12-01T10:01:15.391224 #31755] INFO -- : Reloading nginx service. I, [2016-12-01T10:01:15.445962 #31755] INFO -- : Reloading nginx service. I, [2016-12-01T10:01:15.482892 #31755] INFO -- : Only saw one machine, therefore my node is also a slave node I, [2016-12-01T10:01:15.538640 #31755] INFO -- : Starting API Services. I, [2016-12-01T10:01:15.538878 #31755] INFO -- : Trying to use zookeeper server at 104.131.100.138. W, [2016-12-01T10:01:15.539438 #31755] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). sed: can't read /etc/zookeeper/conf/environment: No such file or directory I, [2016-12-01T10:01:15.573058 #31755] INFO -- : Starting zookeeper. W, [2016-12-01T10:01:16.540843 #31755] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). W, [2016-12-01T10:01:17.542026 #31755] WARN -- : [is_port_open](104.131.100.138, 2181): got Connection refused - connect(2). I, [2016-12-01T10:01:18.383858 #31755] INFO -- : Starting zookeeper on port 2181 with start command [/usr/sbin/service zookeeper-server start] and stop command [/usr/sbin/service zookeeper-server stop] I, [2016-12-01T10:01:18.406133 #31755] INFO -- : Done configuring zookeeper. I, [2016-12-01T10:01:18.649048 #31755] INFO -- : Set custom cassandra configuration. I, [2016-12-01T10:01:19.367517 #31755] INFO -- : Waiting for DB services ... I, [2016-12-01T10:01:19.367871 #31755] INFO -- : Starting database services. I, [2016-12-01T10:01:19.368280 #31755] INFO -- : Starting up Cassandra seed node I, [2016-12-01T10:01:21.407761 #31755] INFO -- : Starting cassandra on port 9999 with start command [su -c "/opt/cassandra/cassandra/bin/cassandra -p /tmp/appscale-cassandra.pid" cassandra] and stop command [/bin/bash -c 'kill $(cat /tmp/appscale-cassandra.pid)'] I, [2016-12-01T10:01:21.459136 #31755] INFO -- : Waiting for Cassandra to start