Grakn Engine .... FAILED


#1

Just installed an OSX update 10.13.5 (just beforehand I was being a tad silly and terminated the shell running grakn without running grakn server stop first).

  1. 1.2.0

  2. OSX 10.13.5

  3. brew installed grakn

  4. ` Harrys-MacBook-Pro-2:bin hcbh96$ grakn server start

       ________  _____     _______  __    __  __    __      _______  ___
      |   __   ||   _  \  |   _   ||  |  /  /|  \  |  |    |   _   ||   |
      |  |  |__||  | |  | |  | |  ||  | /  / |   \ |  |    |  | |  ||   |
      |  | ____ |  |_| /  |  |_|  ||  |/  /  |    \|  |    |  |_|  ||   |
      |  ||_   ||   _  \  |   _   ||   _  \  |   _    |    |   _   ||   |
      |  |__|  ||  | \  \ |  | |  ||  | \  \ |  | \   | __ |  | |  ||   |
      |________||__|  \__\|__| |__||__|  \__\|__|  \__||__||__| |__||___|
    
                           Grakn: The Database For AI
     =============================================================================
    
     Starting Storage.....SUCCESS
     Starting Queue.....SUCCESS
     Starting Engine........................................................................................................................................................FAILED!
     Unable to start Engine
     Please run 'grakn server status' or check the logs located under 'logs' directory.`
    
  5.     `Harrys-MacBook-Pro-2:bin hcbh96$ ls -la /tmp/*.pid
     -rw-r--r--  1 hcbh96  wheel  4 Jun  7 17:00 /tmp/grakn-engine.pid
     -rw-r--r--  1 hcbh96  wheel  5 Jun  7 17:00 /tmp/grakn-queue.pid
     -rw-r--r--  1 hcbh96  wheel  4 Jun  7 17:00 /tmp/grakn-storage.pid
     Harrys-MacBook-Pro-2:bin hcbh96$ 
     Harrys-MacBook-Pro-2:bin hcbh96$ ps -ef | grep redis-server
       501  3884     1   0  5:00PM ??         0:05.63 /usr/local/Cellar/grakn/1.2.0/libexec/services/redis/redis-server-osx 127.0.0.1:6379 
       501  4545   544   0  5:14PM ttys000    0:00.00 grep redis-server
     Harrys-MacBook-Pro-2:bin hcbh96$ jps
     4546 Jps
     3890 Grakn
     3785 CassandraDaemon`

#2
  1.      ` INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,503 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_test/systemlog-53a21da068db11e897314df31e36308d/phonebox_test-systemlog-ka-1 (93 bytes)
     INFO  [main] 2018-06-07 17:00:48,510 ColumnFamilyStore.java:365 - Initializing phonebox_test.txlog
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,511 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_test/txlog-532db0f068db11e897314df31e36308d/phonebox_test-txlog-ka-1 (101 bytes)
     INFO  [main] 2018-06-07 17:00:48,518 ColumnFamilyStore.java:365 - Initializing phonebox_test.edgestore
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,520 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_test/edgestore-530d7ec068db11e897314df31e36308d/phonebox_test-edgestore-ka-1 (206657 bytes)
     INFO  [main] 2018-06-07 17:00:48,526 ColumnFamilyStore.java:365 - Initializing phonebox_test.system_properties_lock_
     INFO  [main] 2018-06-07 17:00:48,531 ColumnFamilyStore.java:365 - Initializing phonebox_development.graphindex_lock_
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,532 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/graphindex_lock_-cb65f7a068ca11e897314df31e36308d/phonebox_development-graphindex_lock_-ka-1 (1700 bytes)
     INFO  [main] 2018-06-07 17:00:48,539 ColumnFamilyStore.java:365 - Initializing phonebox_development.graphindex
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,541 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/graphindex-cb195e4068ca11e897314df31e36308d/phonebox_development-graphindex-ka-1 (134434 bytes)
     INFO  [SSTableBatchOpen:2] 2018-06-07 17:00:48,541 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/graphindex-cb195e4068ca11e897314df31e36308d/phonebox_development-graphindex-ka-2 (80296 bytes)
     INFO  [main] 2018-06-07 17:00:48,550 ColumnFamilyStore.java:365 - Initializing phonebox_development.janusgraph_ids
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,552 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/janusgraph_ids-cae073f068ca11e897314df31e36308d/phonebox_development-janusgraph_ids-ka-1 (573 bytes)
     INFO  [main] 2018-06-07 17:00:48,557 ColumnFamilyStore.java:365 - Initializing phonebox_development.system_properties
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,559 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/system_properties-cabda9b068ca11e897314df31e36308d/phonebox_development-system_properties-ka-1 (407 bytes)
     INFO  [SSTableBatchOpen:2] 2018-06-07 17:00:48,560 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/system_properties-cabda9b068ca11e897314df31e36308d/phonebox_development-system_properties-ka-2 (126 bytes)
     INFO  [main] 2018-06-07 17:00:48,567 ColumnFamilyStore.java:365 - Initializing phonebox_development.edgestore_lock_
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,569 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/edgestore_lock_-cb04018068ca11e897314df31e36308d/phonebox_development-edgestore_lock_-ka-1 (13500 bytes)
     INFO  [SSTableBatchOpen:2] 2018-06-07 17:00:48,569 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/edgestore_lock_-cb04018068ca11e897314df31e36308d/phonebox_development-edgestore_lock_-ka-2 (106515 bytes)
     INFO  [main] 2018-06-07 17:00:48,574 ColumnFamilyStore.java:365 - Initializing phonebox_development.systemlog
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,576 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/systemlog-ccb9c7d068ca11e897314df31e36308d/phonebox_development-systemlog-ka-1 (93 bytes)
     INFO  [main] 2018-06-07 17:00:48,581 ColumnFamilyStore.java:365 - Initializing phonebox_development.txlog
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,583 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/txlog-cc83759068ca11e897314df31e36308d/phonebox_development-txlog-ka-1 (101 bytes)
     INFO  [main] 2018-06-07 17:00:48,588 ColumnFamilyStore.java:365 - Initializing phonebox_development.edgestore
     INFO  [SSTableBatchOpen:1] 2018-06-07 17:00:48,590 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/edgestore-caf2755068ca11e897314df31e36308d/phonebox_development-edgestore-ka-2 (331528 bytes)
     INFO  [SSTableBatchOpen:2] 2018-06-07 17:00:48,591 SSTableReader.java:475 - Opening db/cassandra/data/phonebox_development/edgestore-caf2755068ca11e897314df31e36308d/phonebox_development-edgestore-ka-1 (754900 bytes)
     INFO  [main] 2018-06-07 17:00:48,597 ColumnFamilyStore.java:365 - Initializing phonebox_development.system_properties_lock_
     INFO  [main] 2018-06-07 17:00:48,600 ColumnFamilyStore.java:365 - Initializing system_traces.sessions
     INFO  [main] 2018-06-07 17:00:48,602 ColumnFamilyStore.java:365 - Initializing system_traces.events
     INFO  [pool-3-thread-1] 2018-06-07 17:00:48,609 AutoSavingCache.java:179 - reading saved cache db/cassandra/saved_caches/KeyCache-ba.db
     INFO  [pool-3-thread-1] 2018-06-07 17:00:48,685 AutoSavingCache.java:156 - Completed loading (78 ms; 2949 keys) KeyCache cache
     INFO  [main] 2018-06-07 17:00:48,704 CommitLog.java:128 - Replaying db/cassandra/commitlog/CommitLog-4-1528386132800.log, db/cassandra/commitlog/CommitLog-4-1528386132801.log
     INFO  [main] 2018-06-07 17:00:48,718 CommitLogReplayer.java:267 - Replaying db/cassandra/commitlog/CommitLog-4-1528386132800.log
     INFO  [main] 2018-06-07 17:00:48,719 CommitLogReplayer.java:270 - Replaying db/cassandra/commitlog/CommitLog-4-1528386132800.log (CL version 4, messaging version 8)
     INFO  [main] 2018-06-07 17:00:48,965 CommitLogReplayer.java:478 - Finished reading db/cassandra/commitlog/CommitLog-4-1528386132800.log
     INFO  [main] 2018-06-07 17:00:48,965 CommitLogReplayer.java:267 - Replaying db/cassandra/commitlog/CommitLog-4-1528386132801.log
     INFO  [main] 2018-06-07 17:00:48,975 CommitLogReplayer.java:270 - Replaying db/cassandra/commitlog/CommitLog-4-1528386132801.log (CL version 4, messaging version 8)
     INFO  [main] 2018-06-07 17:00:48,976 CommitLogReplayer.java:478 - Finished reading db/cassandra/commitlog/CommitLog-4-1528386132801.log
     INFO  [main] 2018-06-07 17:00:48,986 ColumnFamilyStore.java:917 - Enqueuing flush of systemlog: 354 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:48,988 Memtable.java:347 - Writing Memtable-systemlog@274382544(0.024KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:48,989 Memtable.java:382 - Completed flushing db/cassandra/data/graknsystem/systemlog-86592f505cc311e8bee4f7c20bbc612b/graknsystem-systemlog-tmp-ka-7-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [main] 2018-06-07 17:00:48,993 ColumnFamilyStore.java:917 - Enqueuing flush of txlog: 354 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:48,993 Memtable.java:347 - Writing Memtable-txlog@1412926716(0.032KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:48,995 Memtable.java:382 - Completed flushing db/cassandra/data/graknsystem/txlog-86472df05cc311e8bee4f7c20bbc612b/graknsystem-txlog-tmp-ka-7-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [main] 2018-06-07 17:00:48,997 ColumnFamilyStore.java:917 - Enqueuing flush of system_properties: 477 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,000 ColumnFamilyStore.java:917 - Enqueuing flush of compaction_history: 6540 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,001 ColumnFamilyStore.java:917 - Enqueuing flush of schema_columnfamilies: 103212 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,002 ColumnFamilyStore.java:917 - Enqueuing flush of schema_triggers: 154 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,003 ColumnFamilyStore.java:917 - Enqueuing flush of size_estimates: 349616 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,003 ColumnFamilyStore.java:917 - Enqueuing flush of peers: 168 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,004 ColumnFamilyStore.java:917 - Enqueuing flush of schema_keyspaces: 471 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,004 ColumnFamilyStore.java:917 - Enqueuing flush of schema_usertypes: 154 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,005 ColumnFamilyStore.java:917 - Enqueuing flush of sstable_activity: 34794 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,012 Memtable.java:347 - Writing Memtable-system_properties@632279078(0.091KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,013 Memtable.java:382 - Completed flushing db/cassandra/data/graknsystem/system_properties-856532605cc311e8bee4f7c20bbc612b/graknsystem-system_properties-tmp-ka-11-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [main] 2018-06-07 17:00:49,020 ColumnFamilyStore.java:917 - Enqueuing flush of schema_columns: 232677 (0%) on-heap, 0 (0%) off-heap
     INFO  [main] 2018-06-07 17:00:49,021 ColumnFamilyStore.java:917 - Enqueuing flush of batchlog: 3370 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,031 Memtable.java:347 - Writing Memtable-compaction_history@623917109(1.312KiB serialized bytes, 48 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,037 Memtable.java:382 - Completed flushing db/cassandra/data/system/compaction_history-b4dbb7b4dc493fb5b3bfce6e434832ca/system-compaction_history-tmp-ka-961-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,041 Memtable.java:347 - Writing Memtable-schema_columnfamilies@514913942(26.712KiB serialized bytes, 460 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,052 Memtable.java:382 - Completed flushing db/cassandra/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-tmp-ka-1266-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,071 Memtable.java:347 - Writing Memtable-schema_triggers@1002114663(0.008KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,079 Memtable.java:347 - Writing Memtable-size_estimates@1753842717(42.100KiB serialized bytes, 2632 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,080 Memtable.java:382 - Completed flushing db/cassandra/data/system/schema_triggers-0359bc7171233ee19a4ab9dfb11fc125/system-schema_triggers-tmp-ka-130-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,098 Memtable.java:347 - Writing Memtable-peers@587730443(0.008KiB serialized bytes, 2 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,100 Memtable.java:382 - Completed flushing db/cassandra/data/system/peers-37f71aca7dc2383ba70672528af04d4f/system-peers-tmp-ka-2-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,107 Memtable.java:382 - Completed flushing db/cassandra/data/system/size_estimates-618f817b005f3678b8a453f3930b8e86/system-size_estimates-tmp-ka-1268-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,122 Memtable.java:347 - Writing Memtable-schema_keyspaces@379290224(0.118KiB serialized bytes, 4 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,123 Memtable.java:382 - Completed flushing db/cassandra/data/system/schema_keyspaces-b0f2235744583cdb9631c43e59ce3676/system-schema_keyspaces-tmp-ka-1392-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,146 Memtable.java:347 - Writing Memtable-schema_usertypes@1813297384(0.008KiB serialized bytes, 1 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,147 Memtable.java:382 - Completed flushing db/cassandra/data/system/schema_usertypes-3aa752254f82350b8d5c430fa221fa0a/system-schema_usertypes-tmp-ka-130-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,149 Memtable.java:347 - Writing Memtable-sstable_activity@703752300(4.328KiB serialized bytes, 596 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,156 Memtable.java:382 - Completed flushing db/cassandra/data/system/sstable_activity-5a1ff267ace03f128563cfae6103c65e/system-sstable_activity-tmp-ka-1282-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,168 Memtable.java:347 - Writing Memtable-schema_columns@739234377(43.692KiB serialized bytes, 855 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,177 Memtable.java:347 - Writing Memtable-batchlog@1407013457(0.826KiB serialized bytes, 20 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,178 Memtable.java:393 - Completed flushing db/cassandra/data/system/batchlog-0290003c977e397cac3efdfdc01d626b/system-batchlog-tmp-ka-1-Data.db; nothing needed to be retained.  Commitlog position was ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,178 Memtable.java:382 - Completed flushing db/cassandra/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-tmp-ka-1266-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=279)
     INFO  [main] 2018-06-07 17:00:49,207 CommitLog.java:130 - Log replay complete, 427 replayed mutations
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,215 CompactionTask.java:141 - Compacting [SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-ka-1263-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-ka-1266-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-ka-1264-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-ka-1265-Data.db')]
     INFO  [CompactionExecutor:2] 2018-06-07 17:00:49,215 CompactionTask.java:141 - Compacting [SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/compaction_history-b4dbb7b4dc493fb5b3bfce6e434832ca/system-compaction_history-ka-958-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/compaction_history-b4dbb7b4dc493fb5b3bfce6e434832ca/system-compaction_history-ka-959-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/compaction_history-b4dbb7b4dc493fb5b3bfce6e434832ca/system-compaction_history-ka-960-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/compaction_history-b4dbb7b4dc493fb5b3bfce6e434832ca/system-compaction_history-ka-961-Data.db')]
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,341 CompactionTask.java:274 - Compacted 4 sstables to [db/cassandra/data/system/schema_columnfamilies-45f5b36024bc3f83a3631034ea4fa697/system-schema_columnfamilies-ka-1267,].  41,569 bytes to 23,048 (~55% of original) in 122ms = 0.180166MB/s.  10 total partitions merged to 7.  Partition merge counts were {1:6, 4:1, }
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,351 CompactionTask.java:141 - Compacting [SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/sstable_activity-5a1ff267ace03f128563cfae6103c65e/system-sstable_activity-ka-1279-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/sstable_activity-5a1ff267ace03f128563cfae6103c65e/system-sstable_activity-ka-1280-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/sstable_activity-5a1ff267ace03f128563cfae6103c65e/system-sstable_activity-ka-1281-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/sstable_activity-5a1ff267ace03f128563cfae6103c65e/system-sstable_activity-ka-1282-Data.db')]
     INFO  [main] 2018-06-07 17:00:49,393 StorageService.java:622 - Cassandra version: 2.1.17
     INFO  [main] 2018-06-07 17:00:49,393 StorageService.java:623 - Thrift API version: 19.39.0
     INFO  [main] 2018-06-07 17:00:49,411 StorageService.java:624 - CQL supported versions: 2.0.0,3.2.1 (default: 3.2.1)
     INFO  [main] 2018-06-07 17:00:49,451 IndexSummaryManager.java:95 - Initializing index summary manager with a memory pool size of 100 MB and a resize interval of 60 minutes
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,482 CompactionTask.java:274 - Compacted 4 sstables to [db/cassandra/data/system/sstable_activity-5a1ff267ace03f128563cfae6103c65e/system-sstable_activity-ka-1283,].  8,771 bytes to 1,887 (~21% of original) in 129ms = 0.013950MB/s.  264 total partitions merged to 48.  Partition merge counts were {1:64, 2:4, 3:8, 4:42, }
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,483 CompactionTask.java:141 - Compacting [SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-ka-1263-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-ka-1264-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-ka-1265-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-ka-1266-Data.db')]
     INFO  [main] 2018-06-07 17:00:49,485 StorageService.java:649 - Loading persisted ring state
     INFO  [main] 2018-06-07 17:00:49,519 StorageService.java:807 - Starting up server gossip
     INFO  [main] 2018-06-07 17:00:49,522 ColumnFamilyStore.java:917 - Enqueuing flush of local: 1831 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,523 Memtable.java:347 - Writing Memtable-local@2117682132(0.338KiB serialized bytes, 13 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,524 Memtable.java:382 - Completed flushing db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-tmp-ka-1158-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=94967)
     INFO  [main] 2018-06-07 17:00:49,552 YamlConfigurationLoader.java:92 - Loading settings from file:/usr/local/Cellar/grakn/1.2.0/libexec/services/cassandra/cassandra.yaml
     INFO  [main] 2018-06-07 17:00:49,557 YamlConfigurationLoader.java:135 - Node configuration:[authenticator=AllowAllAuthenticator; authorizer=AllowAllAuthorizer; auto_snapshot=true; batch_size_warn_threshold_in_kb=5; batchlog_replay_throttle_in_kb=1024; cas_contention_timeout_in_ms=1000; client_encryption_options=<REDACTED>; cluster_name=Grakn Example Cluster; column_index_size_in_kb=64; commit_failure_policy=stop; commitlog_directory=db/cassandra/commitlog; commitlog_segment_size_in_mb=32; commitlog_sync=periodic; commitlog_sync_period_in_ms=10000; compaction_large_partition_warning_threshold_mb=100; compaction_throughput_mb_per_sec=16; concurrent_counter_writes=32; concurrent_reads=32; concurrent_writes=32; counter_cache_save_period=7200; counter_cache_size_in_mb=null; counter_write_request_timeout_in_ms=5000; cross_node_timeout=false; data_file_directories=[db/cassandra/data]; disk_failure_policy=stop; dynamic_snitch_badness_threshold=0.1; dynamic_snitch_reset_interval_in_ms=600000; dynamic_snitch_update_interval_in_ms=100; endpoint_snitch=SimpleSnitch; hinted_handoff_enabled=true; hinted_handoff_throttle_in_kb=1024; incremental_backups=false; index_summary_capacity_in_mb=null; index_summary_resize_interval_in_minutes=60; inter_dc_tcp_nodelay=false; internode_compression=all; key_cache_save_period=14400; key_cache_size_in_mb=null; listen_address=localhost; max_hint_window_in_ms=10800000; max_hints_delivery_threads=2; memtable_allocation_type=heap_buffers; native_transport_port=9042; num_tokens=4; partitioner=org.apache.cassandra.dht.Murmur3Partitioner; permissions_validity_in_ms=2000; range_request_timeout_in_ms=10000; read_request_timeout_in_ms=5000; request_scheduler=org.apache.cassandra.scheduler.NoScheduler; request_timeout_in_ms=10000; row_cache_save_period=0; row_cache_size_in_mb=0; rpc_address=localhost; rpc_keepalive=true; rpc_port=9160; rpc_server_type=sync; saved_caches_directory=db/cassandra/saved_caches; seed_provider=[{class_name=org.apache.cassandra.locator.SimpleSeedProvider, parameters=[{seeds=127.0.0.1}]}]; server_encryption_options=<REDACTED>; snapshot_before_compaction=false; ssl_storage_port=7001; sstable_preemptive_open_interval_in_mb=50; start_native_transport=true; start_rpc=true; storage_port=7000; thrift_framed_transport_size_in_mb=15; tombstone_failure_threshold=100000; tombstone_warn_threshold=1000; trickle_fsync=false; trickle_fsync_interval_in_kb=10240; truncate_request_timeout_in_ms=60000; unlogged_batch_across_partitions_warn_threshold=10; write_request_timeout_in_ms=2000]
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,594 CompactionTask.java:274 - Compacted 4 sstables to [db/cassandra/data/system/schema_columns-296e9c049bec3085827dc17d3df2122a/system-schema_columns-ka-1267,].  51,682 bytes to 20,923 (~40% of original) in 110ms = 0.181398MB/s.  10 total partitions merged to 7.  Partition merge counts were {1:6, 4:1, }
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,640 CompactionTask.java:141 - Compacting [SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-ka-1158-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-ka-1157-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-ka-1156-Data.db'), SSTableReader(path='/usr/local/Cellar/grakn/1.2.0/libexec/db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-ka-1155-Data.db')]
     INFO  [CompactionExecutor:1] 2018-06-07 17:00:49,685 CompactionTask.java:274 - Compacted 4 sstables to [db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-ka-1159,].  1,289 bytes to 659 (~51% of original) in 43ms = 0.014616MB/s.  4 total partitions merged to 1.  Partition merge counts were {4:1, }
     INFO  [main] 2018-06-07 17:00:49,719 MessagingService.java:506 - Starting Messaging Service on port 7000
     INFO  [main] 2018-06-07 17:00:49,742 YamlConfigurationLoader.java:92 - Loading settings from file:/usr/local/Cellar/grakn/1.2.0/libexec/services/cassandra/cassandra.yaml
     INFO  [main] 2018-06-07 17:00:49,746 YamlConfigurationLoader.java:135 - Node configuration:[authenticator=AllowAllAuthenticator; authorizer=AllowAllAuthorizer; auto_snapshot=true; batch_size_warn_threshold_in_kb=5; batchlog_replay_throttle_in_kb=1024; cas_contention_timeout_in_ms=1000; client_encryption_options=<REDACTED>; cluster_name=Grakn Example Cluster; column_index_size_in_kb=64; commit_failure_policy=stop; commitlog_directory=db/cassandra/commitlog; commitlog_segment_size_in_mb=32; commitlog_sync=periodic; commitlog_sync_period_in_ms=10000; compaction_large_partition_warning_threshold_mb=100; compaction_throughput_mb_per_sec=16; concurrent_counter_writes=32; concurrent_reads=32; concurrent_writes=32; counter_cache_save_period=7200; counter_cache_size_in_mb=null; counter_write_request_timeout_in_ms=5000; cross_node_timeout=false; data_file_directories=[db/cassandra/data]; disk_failure_policy=stop; dynamic_snitch_badness_threshold=0.1; dynamic_snitch_reset_interval_in_ms=600000; dynamic_snitch_update_interval_in_ms=100; endpoint_snitch=SimpleSnitch; hinted_handoff_enabled=true; hinted_handoff_throttle_in_kb=1024; incremental_backups=false; index_summary_capacity_in_mb=null; index_summary_resize_interval_in_minutes=60; inter_dc_tcp_nodelay=false; internode_compression=all; key_cache_save_period=14400; key_cache_size_in_mb=null; listen_address=localhost; max_hint_window_in_ms=10800000; max_hints_delivery_threads=2; memtable_allocation_type=heap_buffers; native_transport_port=9042; num_tokens=4; partitioner=org.apache.cassandra.dht.Murmur3Partitioner; permissions_validity_in_ms=2000; range_request_timeout_in_ms=10000; read_request_timeout_in_ms=5000; request_scheduler=org.apache.cassandra.scheduler.NoScheduler; request_timeout_in_ms=10000; row_cache_save_period=0; row_cache_size_in_mb=0; rpc_address=localhost; rpc_keepalive=true; rpc_port=9160; rpc_server_type=sync; saved_caches_directory=db/cassandra/saved_caches; seed_provider=[{class_name=org.apache.cassandra.locator.SimpleSeedProvider, parameters=[{seeds=127.0.0.1}]}]; server_encryption_options=<REDACTED>; snapshot_before_compaction=false; ssl_storage_port=7001; sstable_preemptive_open_interval_in_mb=50; start_native_transport=true; start_rpc=true; storage_port=7000; thrift_framed_transport_size_in_mb=15; tombstone_failure_threshold=100000; tombstone_warn_threshold=1000; trickle_fsync=false; trickle_fsync_interval_in_kb=10240; truncate_request_timeout_in_ms=60000; unlogged_batch_across_partitions_warn_threshold=10; write_request_timeout_in_ms=2000]
     INFO  [main] 2018-06-07 17:00:49,756 StorageService.java:974 - Using saved tokens [-6287126735825265934, 2324387867135391028, 7780273095248515898, 8197565574643650185]
     INFO  [main] 2018-06-07 17:00:49,757 ColumnFamilyStore.java:917 - Enqueuing flush of local: 578 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,758 Memtable.java:347 - Writing Memtable-local@1691631464(0.081KiB serialized bytes, 4 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:1] 2018-06-07 17:00:49,759 Memtable.java:382 - Completed flushing db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-tmp-ka-1160-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=96773)
     INFO  [main] 2018-06-07 17:00:49,811 ColumnFamilyStore.java:917 - Enqueuing flush of local: 1086 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,812 Memtable.java:347 - Writing Memtable-local@939299419(0.146KiB serialized bytes, 7 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:2] 2018-06-07 17:00:49,813 Memtable.java:382 - Completed flushing db/cassandra/data/system/local-7ad54392bcdd35a684174e047860b377/system-local-tmp-ka-1161-Data.db (0.000KiB) for commitlog position ReplayPosition(segmentId=1528387247373, position=97070)
     INFO  [main] 2018-06-07 17:00:49,838 StorageService.java:1715 - Node localhost/127.0.0.1 state jump to NORMAL
     INFO  [CompactionExecutor:2] 2018-06-07 17:00:49,871 CompactionTask.java:274 - Compacted 4 sstables to [db/cassandra/data/system/compaction_history-b4dbb7b4dc493fb5b3bfce6e434832ca/system-compaction_history-ka-962,].  135,201 bytes to 134,747 (~99% of original) in 655ms = 0.196190MB/s.  1,503 total partitions merged to 1,503.  Partition merge counts were {1:1503, }
     INFO  [main] 2018-06-07 17:00:50,090 Server.java:160 - Netty using Java NIO event loop
     INFO  [main] 2018-06-07 17:00:50,275 Server.java:193 - Using Netty Version: [netty-buffer=netty-buffer-4.1.16.Final.f57d8f0, netty-codec=netty-codec-4.1.16.Final.f57d8f0, netty-codec-dns=netty-codec-dns-4.1.16.Final.f57d8f0, netty-codec-haproxy=netty-codec-haproxy-4.1.16.Final.f57d8f0, netty-codec-http=netty-codec-http-4.1.16.Final.f57d8f0, netty-codec-http2=netty-codec-http2-4.1.16.Final.f57d8f0, netty-codec-memcache=netty-codec-memcache-4.1.16.Final.f57d8f0, netty-codec-mqtt=netty-codec-mqtt-4.1.16.Final.f57d8f0, netty-codec-redis=netty-codec-redis-4.1.16.Final.f57d8f0, netty-codec-smtp=netty-codec-smtp-4.1.16.Final.f57d8f0, netty-codec-socks=netty-codec-socks-4.1.16.Final.f57d8f0, netty-codec-stomp=netty-codec-stomp-4.1.16.Final.f57d8f0, netty-codec-xml=netty-codec-xml-4.1.16.Final.f57d8f0, netty-common=netty-common-4.1.16.Final.f57d8f0, netty-handler=netty-handler-4.1.16.Final.f57d8f0, netty-handler-proxy=netty-handler-proxy-4.1.16.Final.f57d8f0, netty-resolver=netty-resolver-4.1.16.Final.f57d8f0, netty-resolver-dns=netty-resolver-dns-4.1.16.Final.f57d8f0, netty-tcnative=netty-tcnative-2.0.6.Final.67f1d2d, netty-tcnative-boringssl-static=netty-tcnative-boringssl-static-1.1.33.Fork19.fe4816e (repository: dirty), netty-transport=netty-transport-4.1.16.Final.f57d8f0, netty-transport-native-epoll=netty-transport-native-epoll-4.1.16.Final.f57d8f0, netty-transport-native-kqueue=netty-transport-native-kqueue-4.1.16.Final.f57d8f00e1, netty-transport-native-unix-common=netty-transport-native-unix-common-4.1.16.Final.f57d8f00e1, netty-transport-rxtx=netty-transport-rxtx-4.1.16.Final.f57d8f0, netty-transport-sctp=netty-transport-sctp-4.1.16.Final.f57d8f0, netty-transport-udt=netty-transport-udt-4.1.16.Final.f57d8f0]
     INFO  [main] 2018-06-07 17:00:50,275 Server.java:194 - Starting listening for CQL clients on localhost/127.0.0.1:9042...
     INFO  [main] 2018-06-07 17:00:50,448 ThriftServer.java:119 - Binding thrift service to localhost/127.0.0.1:9160
     INFO  [Thread-2] 2018-06-07 17:00:50,460 ThriftServer.java:136 - Listening for thrift clients...
     WARN  [Thrift:4] 2018-06-07 17:01:56,140 FBUtilities.java:310 - Trigger directory doesn't exist, please create it and try again.
     INFO  [BatchlogTasks:1] 2018-06-07 17:02:19,755 ColumnFamilyStore.java:917 - Enqueuing flush of batchlog: 865 (0%) on-heap, 0 (0%) off-heap
     INFO  [MemtableFlushWriter:3] 2018-06-07 17:02:19,757 Memtable.java:347 - Writing Memtable-batchlog@1483391351(0.229KiB serialized bytes, 5 ops, 0%/0% of on/off-heap limit)
     INFO  [MemtableFlushWriter:3] 2018-06-07 17:02:19,758 Memtable.java:393 - Completed flushing db/cassandra/data/system/batchlog-0290003c977e397cac3efdfdc01d626b/system-batchlog-tmp-ka-2-Data.db; nothing needed to be retained.  Commitlog position was ReplayPosition(segmentId=1528387247373, position=167695)`

#3

Harrys-MacBook-Pro-2:bin hcbh96$ tail -n 200 /usr/local/Cellar/grakn/1.2.0/libexec/logs/grakn.log 2018-06-07 16:09:59,556 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:09:59,559 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:09:59,559 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:10:09,554 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:10:09,558 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:10:09,560 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:10:09,560 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:25,045 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:25,048 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:25,051 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:25,051 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:29,124 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:29,124 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:43,297 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:43,301 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:43,303 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:43,303 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:43,304 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:43,304 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:43,676 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:43,676 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:54,280 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:11:54,287 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:11:54,810 [main] INFO a.g.engine.task.BackgroundTaskRunner - Registering a new background task. 2018-06-07 16:11:54,858 [main] ERROR ai.grakn.bootup.graknengine.Grakn - Uncaught exception at thread [main] redis.clients.jedis.exceptions.JedisException: Could not get a resource from the pool at redis.clients.util.Pool.getResource(Pool.java:51) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:226) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:16) at ai.grakn.engine.data.RedisWrapper.testConnection(RedisWrapper.java:86) at ai.grakn.engine.data.RedisSanityCheck.testConnection(RedisSanityCheck.java:44) at ai.grakn.engine.GraknEngineServer.start(GraknEngineServer.java:69) at ai.grakn.bootup.graknengine.Grakn.main(Grakn.java:66) Caused by: java.util.NoSuchElementException: Unable to validate object at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:506) at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:363) at redis.clients.util.Pool.getResource(Pool.java:49) ... 6 common frames omitted 2018-06-07 16:19:58,960 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:19:58,964 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:19:58,967 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:19:58,967 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:05,250 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:05,254 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:05,256 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:05,256 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:13,731 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:13,735 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:13,737 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:13,737 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:13,739 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:13,739 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:14,202 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:14,202 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:24,425 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:20:24,429 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:20:24,961 [main] INFO a.g.engine.task.BackgroundTaskRunner - Registering a new background task. 2018-06-07 16:20:25,016 [main] ERROR ai.grakn.bootup.graknengine.Grakn - Uncaught exception at thread [main] redis.clients.jedis.exceptions.JedisException: Could not get a resource from the pool at redis.clients.util.Pool.getResource(Pool.java:51) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:226) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:16) at ai.grakn.engine.data.RedisWrapper.testConnection(RedisWrapper.java:86) at ai.grakn.engine.data.RedisSanityCheck.testConnection(RedisSanityCheck.java:44) at ai.grakn.engine.GraknEngineServer.start(GraknEngineServer.java:69) at ai.grakn.bootup.graknengine.Grakn.main(Grakn.java:66) Caused by: java.util.NoSuchElementException: Unable to validate object at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:506) at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:363) at redis.clients.util.Pool.getResource(Pool.java:49) ... 6 common frames omitted 2018-06-07 16:25:32,477 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:25:32,481 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:25:32,483 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:25:32,483 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:28:56,477 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:28:56,481 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:28:56,483 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:28:56,483 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:00,545 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:00,545 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:13,999 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:14,003 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:14,005 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:14,005 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:18,982 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:18,985 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:18,987 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:18,988 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:18,989 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:18,989 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:19,330 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:19,330 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:29,544 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:29:29,548 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:29:30,053 [main] INFO a.g.engine.task.BackgroundTaskRunner - Registering a new background task. 2018-06-07 16:29:30,099 [main] ERROR ai.grakn.bootup.graknengine.Grakn - Uncaught exception at thread [main] redis.clients.jedis.exceptions.JedisException: Could not get a resource from the pool at redis.clients.util.Pool.getResource(Pool.java:51) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:226) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:16) at ai.grakn.engine.data.RedisWrapper.testConnection(RedisWrapper.java:86) at ai.grakn.engine.data.RedisSanityCheck.testConnection(RedisSanityCheck.java:44) at ai.grakn.engine.GraknEngineServer.start(GraknEngineServer.java:69) at ai.grakn.bootup.graknengine.Grakn.main(Grakn.java:66) Caused by: java.util.NoSuchElementException: Unable to validate object at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:506) at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:363) at redis.clients.util.Pool.getResource(Pool.java:49) ... 6 common frames omitted 2018-06-07 16:34:36,548 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:34:36,552 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:34:36,554 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:34:36,554 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:34:40,614 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:34:40,618 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:37:15,502 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:37:15,506 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:37:15,508 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:37:15,508 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:37:27,205 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:37:27,209 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:37:27,211 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:37:27,211 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:02,794 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:02,798 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:02,800 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:02,800 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:08,638 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:08,642 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:08,644 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:08,644 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:08,645 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:08,645 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:08,977 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:08,977 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:19,404 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:42:19,409 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:42:19,932 [main] INFO a.g.engine.task.BackgroundTaskRunner - Registering a new background task. 2018-06-07 16:42:19,981 [main] ERROR ai.grakn.bootup.graknengine.Grakn - Uncaught exception at thread [main] redis.clients.jedis.exceptions.JedisException: Could not get a resource from the pool at redis.clients.util.Pool.getResource(Pool.java:51) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:226) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:16) at ai.grakn.engine.data.RedisWrapper.testConnection(RedisWrapper.java:86) at ai.grakn.engine.data.RedisSanityCheck.testConnection(RedisSanityCheck.java:44) at ai.grakn.engine.GraknEngineServer.start(GraknEngineServer.java:69) at ai.grakn.bootup.graknengine.Grakn.main(Grakn.java:66) Caused by: java.util.NoSuchElementException: Unable to validate object at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:506) at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:363) at redis.clients.util.Pool.getResource(Pool.java:49) ... 6 common frames omitted 2018-06-07 16:57:01,362 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:57:01,365 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:57:01,368 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:57:01,368 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:58:47,964 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:58:47,968 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:58:47,971 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:58:47,971 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 16:58:52,044 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 16:58:52,046 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:34,338 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:34,342 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:34,344 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:34,344 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:43,150 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:43,153 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:43,155 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:43,156 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:43,157 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:43,157 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:43,490 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:43,490 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:54,111 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:00:54,116 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:00:54,609 [main] INFO a.g.engine.task.BackgroundTaskRunner - Registering a new background task. 2018-06-07 17:00:54,662 [main] ERROR ai.grakn.bootup.graknengine.Grakn - Uncaught exception at thread [main] redis.clients.jedis.exceptions.JedisException: Could not get a resource from the pool at redis.clients.util.Pool.getResource(Pool.java:51) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:226) at redis.clients.jedis.JedisPool.getResource(JedisPool.java:16) at ai.grakn.engine.data.RedisWrapper.testConnection(RedisWrapper.java:86) at ai.grakn.engine.data.RedisSanityCheck.testConnection(RedisSanityCheck.java:44) at ai.grakn.engine.GraknEngineServer.start(GraknEngineServer.java:69) at ai.grakn.bootup.graknengine.Grakn.main(Grakn.java:66) Caused by: java.util.NoSuchElementException: Unable to validate object at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:506) at org.apache.commons.pool2.impl.GenericObjectPool.borrowObject(GenericObjectPool.java:363) at redis.clients.util.Pool.getResource(Pool.java:49) ... 6 common frames omitted 2018-06-07 17:06:37,432 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:06:37,435 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:06:37,438 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:06:37,438 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:06:47,298 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:06:47,302 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties 2018-06-07 17:06:47,305 [main] INFO ai.grakn.engine.GraknConfig - Project directory in use: /usr/local/Cellar/grakn/1.2.0/libexec 2018-06-07 17:06:47,305 [main] INFO ai.grakn.engine.GraknConfig - Configuration file in use: /usr/local/Cellar/grakn/1.2.0/libexec/conf/grakn.properties


#4
`Harrys-MacBook-Pro-2:bin hcbh96$ tail -n 200 /usr/local/Cellar/grakn/1.2.0/libexec/logs/grakn-queue.log
    2626:M 07 Jun 14:55:05.051 * 10 changes in 300 seconds. Saving...
    2626:M 07 Jun 14:55:05.056 * Background saving started by pid 18846
    18846:C 07 Jun 14:55:05.063 * DB saved on disk
    2626:M 07 Jun 14:55:05.156 * Background saving terminated with success
    2626:M 07 Jun 15:03:57.284 * 10 changes in 300 seconds. Saving...
    2626:M 07 Jun 15:03:57.285 * Background saving started by pid 18963
    18963:C 07 Jun 15:03:57.296 * DB saved on disk
    2626:M 07 Jun 15:03:57.387 * Background saving terminated with success
    2626:M 07 Jun 15:18:58.070 * 1 changes in 900 seconds. Saving...
    2626:M 07 Jun 15:18:58.073 * Background saving started by pid 19202
    19202:C 07 Jun 15:18:58.091 * DB saved on disk
    2626:M 07 Jun 15:18:58.174 * Background saving terminated with success
    2626:signal-handler (1528382401) Received SIGTERM scheduling shutdown...
    2626:M 07 Jun 15:40:01.669 # User requested shutdown...
    2626:M 07 Jun 15:40:01.674 * Calling fsync() on the AOF file.
    2626:M 07 Jun 15:40:01.675 * Saving the final RDB snapshot before exiting.
    2626:M 07 Jun 15:40:01.682 * DB saved on disk
    2626:M 07 Jun 15:40:01.682 * Removing the pid file.
    2626:M 07 Jun 15:40:01.682 # Redis is now ready to exit, bye bye...
                    _._                                                  
               _.-``__ ''-._                                             
          _.-``    `.  `_.  ''-._           Redis 3.2.9 (00000000/0) 64 bit
      .-`` .-```.  ```\/    _.,_ ''-._                                   
     (    '      ,       .-`  | `,    )     Running in standalone mode
     |`-._`-...-` __...-.``-._|'` _.-'|     Port: 6379
     |    `-._   `._    /     _.-'    |     PID: 1437
      `-._    `-._  `-./  _.-'    _.-'                                   
     |`-._`-._    `-.__.-'    _.-'_.-'|                                  
     |    `-._`-._        _.-'_.-'    |           http://redis.io        
      `-._    `-._`-.__.-'_.-'    _.-'                                   
     |`-._`-._    `-.__.-'    _.-'_.-'|                                  
     |    `-._`-._        _.-'_.-'    |                                  
      `-._    `-._`-.__.-'_.-'    _.-'                                   
          `-._    `-.__.-'    _.-'                                       
              `-._        _.-'                                           
                  `-.__.-'                                               

1437:M 07 Jun 16:01:41.161 # Server started, Redis version 3.2.9
1437:M 07 Jun 16:01:46.382 * DB loaded from append only file: 5.220 seconds
1437:M 07 Jun 16:01:46.382 * The server is now ready to accept connections on port 6379
1437:M 07 Jun 16:02:42.088 * 10000 changes in 60 seconds. Saving...
1437:M 07 Jun 16:02:42.089 * Background saving started by pid 1567
1567:C 07 Jun 16:02:42.093 * DB saved on disk
1437:M 07 Jun 16:02:42.191 * Background saving terminated with success
1437:M 07 Jun 16:11:29.151 # User requested shutdown...
1437:M 07 Jun 16:11:29.151 * Calling fsync() on the AOF file.
1437:M 07 Jun 16:11:29.152 * Saving the final RDB snapshot before exiting.
1437:M 07 Jun 16:11:29.154 * DB saved on disk
1437:M 07 Jun 16:11:29.154 * Removing the pid file.
1437:M 07 Jun 16:11:29.154 # Redis is now ready to exit, bye bye...
                _._                                                  
           _.-``__ ''-._                                             
      _.-``    `.  `_.  ''-._           Redis 3.2.9 (00000000/0) 64 bit
  .-`` .-```.  ```\/    _.,_ ''-._                                   
 (    '      ,       .-`  | `,    )     Running in standalone mode
 |`-._`-...-` __...-.``-._|'` _.-'|     Port: 6379
 |    `-._   `._    /     _.-'    |     PID: 2455
  `-._    `-._  `-./  _.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |           http://redis.io        
  `-._    `-._`-.__.-'_.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |                                  
  `-._    `-._`-.__.-'_.-'    _.-'                                   
      `-._    `-.__.-'    _.-'                                       
          `-._        _.-'                                           
              `-.__.-'                                               

2455:M 07 Jun 16:11:50.918 # Server started, Redis version 3.2.9
2455:M 07 Jun 16:11:56.025 * DB loaded from append only file: 5.107 seconds
2455:M 07 Jun 16:11:56.025 * The server is now ready to accept connections on port 6379
2455:M 07 Jun 16:12:51.082 * 10000 changes in 60 seconds. Saving...
2455:M 07 Jun 16:12:51.085 * Background saving started by pid 2589
2589:C 07 Jun 16:12:51.089 * DB saved on disk
2455:M 07 Jun 16:12:51.187 * Background saving terminated with success
2455:signal-handler (1528384651) Received SIGTERM scheduling shutdown...
2455:M 07 Jun 16:17:31.182 # User requested shutdown...
2455:M 07 Jun 16:17:31.182 * Calling fsync() on the AOF file.
2455:M 07 Jun 16:17:31.183 * Saving the final RDB snapshot before exiting.
2455:M 07 Jun 16:17:31.184 * DB saved on disk
2455:M 07 Jun 16:17:31.184 * Removing the pid file.
2455:M 07 Jun 16:17:31.185 # Redis is now ready to exit, bye bye...
                _._                                                  
           _.-``__ ''-._                                             
      _.-``    `.  `_.  ''-._           Redis 3.2.9 (00000000/0) 64 bit
  .-`` .-```.  ```\/    _.,_ ''-._                                   
 (    '      ,       .-`  | `,    )     Running in standalone mode
 |`-._`-...-` __...-.``-._|'` _.-'|     Port: 6379
 |    `-._   `._    /     _.-'    |     PID: 781
  `-._    `-._  `-./  _.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |           http://redis.io        
  `-._    `-._`-.__.-'_.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |                                  
  `-._    `-._`-.__.-'_.-'    _.-'                                   
      `-._    `-.__.-'    _.-'                                       
          `-._        _.-'                                           
              `-.__.-'                                               

781:M 07 Jun 16:20:21.212 # Server started, Redis version 3.2.9
781:M 07 Jun 16:20:26.267 * DB loaded from append only file: 5.055 seconds
781:M 07 Jun 16:20:26.267 * The server is now ready to accept connections on port 6379
781:M 07 Jun 16:21:22.086 * 10000 changes in 60 seconds. Saving...
781:M 07 Jun 16:21:22.093 * Background saving started by pid 910
910:C 07 Jun 16:21:22.095 * DB saved on disk
781:M 07 Jun 16:21:22.194 * Background saving terminated with success
781:M 07 Jun 16:29:00.571 # User requested shutdown...
781:M 07 Jun 16:29:00.571 * Calling fsync() on the AOF file.
781:M 07 Jun 16:29:00.571 * Saving the final RDB snapshot before exiting.
781:M 07 Jun 16:29:00.573 * DB saved on disk
781:M 07 Jun 16:29:00.573 * Removing the pid file.
781:M 07 Jun 16:29:00.573 # Redis is now ready to exit, bye bye...
                _._                                                  
           _.-``__ ''-._                                             
      _.-``    `.  `_.  ''-._           Redis 3.2.9 (00000000/0) 64 bit
  .-`` .-```.  ```\/    _.,_ ''-._                                   
 (    '      ,       .-`  | `,    )     Running in standalone mode
 |`-._`-...-` __...-.``-._|'` _.-'|     Port: 6379
 |    `-._   `._    /     _.-'    |     PID: 1952
  `-._    `-._  `-./  _.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |           http://redis.io        
  `-._    `-._`-.__.-'_.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |                                  
  `-._    `-._`-.__.-'_.-'    _.-'                                   
      `-._    `-.__.-'    _.-'                                       
          `-._        _.-'                                           
              `-.__.-'                                               

1952:M 07 Jun 16:29:26.296 # Server started, Redis version 3.2.9
1952:M 07 Jun 16:29:31.114 * DB loaded from append only file: 4.818 seconds
1952:M 07 Jun 16:29:31.114 * The server is now ready to accept connections on port 6379
1952:M 07 Jun 16:30:27.047 * 10000 changes in 60 seconds. Saving...
1952:M 07 Jun 16:30:27.054 * Background saving started by pid 2086
2086:C 07 Jun 16:30:27.057 * DB saved on disk
1952:M 07 Jun 16:30:27.156 * Background saving terminated with success
1952:M 07 Jun 16:34:40.643 # User requested shutdown...
1952:M 07 Jun 16:34:40.643 * Calling fsync() on the AOF file.
1952:M 07 Jun 16:34:40.643 * Saving the final RDB snapshot before exiting.
1952:M 07 Jun 16:34:40.645 * DB saved on disk
1952:M 07 Jun 16:34:40.645 * Removing the pid file.
1952:M 07 Jun 16:34:40.645 # Redis is now ready to exit, bye bye...
                _._                                                  
           _.-``__ ''-._                                             
      _.-``    `.  `_.  ''-._           Redis 3.2.9 (00000000/0) 64 bit
  .-`` .-```.  ```\/    _.,_ ''-._                                   
 (    '      ,       .-`  | `,    )     Running in standalone mode
 |`-._`-...-` __...-.``-._|'` _.-'|     Port: 6379
 |    `-._   `._    /     _.-'    |     PID: 2979
  `-._    `-._  `-./  _.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |           http://redis.io        
  `-._    `-._`-.__.-'_.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |                                  
  `-._    `-._`-.__.-'_.-'    _.-'                                   
      `-._    `-.__.-'    _.-'                                       
          `-._        _.-'                                           
              `-.__.-'                                               

2979:M 07 Jun 16:42:16.124 # Server started, Redis version 3.2.9
2979:M 07 Jun 16:42:21.261 * DB loaded from append only file: 5.136 seconds
2979:M 07 Jun 16:42:21.261 * The server is now ready to accept connections on port 6379
2979:M 07 Jun 16:43:17.084 * 10000 changes in 60 seconds. Saving...
2979:M 07 Jun 16:43:17.085 * Background saving started by pid 3110
3110:C 07 Jun 16:43:17.089 * DB saved on disk
2979:M 07 Jun 16:43:17.186 * Background saving terminated with success
2979:M 07 Jun 16:58:52.072 # User requested shutdown...
2979:M 07 Jun 16:58:52.073 * Calling fsync() on the AOF file.
2979:M 07 Jun 16:58:52.073 * Saving the final RDB snapshot before exiting.
2979:M 07 Jun 16:58:52.074 * DB saved on disk
2979:M 07 Jun 16:58:52.074 * Removing the pid file.
2979:M 07 Jun 16:58:52.075 # Redis is now ready to exit, bye bye...
                _._                                                  
           _.-``__ ''-._                                             
      _.-``    `.  `_.  ''-._           Redis 3.2.9 (00000000/0) 64 bit
  .-`` .-```.  ```\/    _.,_ ''-._                                   
 (    '      ,       .-`  | `,    )     Running in standalone mode
 |`-._`-...-` __...-.``-._|'` _.-'|     Port: 6379
 |    `-._   `._    /     _.-'    |     PID: 3884
  `-._    `-._  `-./  _.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |           http://redis.io        
  `-._    `-._`-.__.-'_.-'    _.-'                                   
 |`-._`-._    `-.__.-'    _.-'_.-'|                                  
 |    `-._`-._        _.-'_.-'    |                                  
  `-._    `-._`-.__.-'_.-'    _.-'                                   
      `-._    `-.__.-'    _.-'                                       
          `-._        _.-'                                           
              `-.__.-'                                               

3884:M 07 Jun 17:00:50.714 # Server started, Redis version 3.2.9
3884:M 07 Jun 17:00:55.936 * DB loaded from append only file: 5.221 seconds
3884:M 07 Jun 17:00:55.936 * The server is now ready to accept connections on port 6379
3884:M 07 Jun 17:01:51.086 * 10000 changes in 60 seconds. Saving...
3884:M 07 Jun 17:01:51.087 * Background saving started by pid 4016
4016:C 07 Jun 17:01:51.091 * DB saved on disk
3884:M 07 Jun 17:01:51.189 * Background saving terminated with success`

#5

Sorry about the load of code.