Skip to content

Instantly share code, notes, and snippets.

@trbngr

trbngr/gist:983acda996759ec9fc60 Secret

Created January 30, 2015 21:14
Show Gist options
  • Star 0 You must be signed in to star a gist
  • Fork 0 You must be signed in to fork a gist
  • Save trbngr/983acda996759ec9fc60 to your computer and use it in GitHub Desktop.
Save trbngr/983acda996759ec9fc60 to your computer and use it in GitHub Desktop.
Download ZIP
es.log
Raw
gistfile1.txt
[PID:40501:001 2015.01.30 21:09:13.379 INFO ProgramBase`1 ]
ES VERSION: 3.0.1.0 (release-oss-v3.0.1/7fa876c111888dd5980dbd86d126e6abe13b05ab, Thu, 23 Oct 2014 22:27:04 +0100)
OS: Unknown (Unix 3.16.0.25)
RUNTIME: 3.8.0 ((detached/45d0ba1) (64-bit)
GC: 2 GENERATIONS
LOGS: /var/log/eventstore
HELP: False (<DEFAULT>)
VERSION: False (<DEFAULT>)
LOG: /var/log/eventstore (Config File)
CONFIG: /datadrive/EventStore-OSS-Linux-v3.0.1/eventstore.config (Command Line)
DEFINES: <empty> (<DEFAULT>)
WHAT IF: False (<DEFAULT>)
INT IP: 0.0.0.0 (Config File)
EXT IP: 0.0.0.0 (Config File)
INT HTTP PORT: 2112 (<DEFAULT>)
EXT HTTP PORT: 2113 (<DEFAULT>)
INT TCP PORT: 1112 (<DEFAULT>)
INT SECURE TCP PORT: 0 (<DEFAULT>)
EXT TCP PORT: 1113 (<DEFAULT>)
EXT SECURE TCP PORT: 0 (<DEFAULT>)
INT TCP HEARTBEAT TIMEOUT: 700 (<DEFAULT>)
EXT TCP HEARTBEAT TIMEOUT: 1000 (<DEFAULT>)
INT TCP HEARTBEAT INTERVAL: 700 (<DEFAULT>)
EXT TCP HEARTBEAT INTERVAL: 2000 (<DEFAULT>)
FORCE: False (<DEFAULT>)
CLUSTER SIZE: 1 (<DEFAULT>)
NODE PRIORITY: 0 (<DEFAULT>)
MIN FLUSH DELAY MS: 2 (<DEFAULT>)
COMMIT COUNT: -1 (<DEFAULT>)
PREPARE COUNT: -1 (<DEFAULT>)
ADMIN ON EXT: True (<DEFAULT>)
STATS ON EXT: True (<DEFAULT>)
GOSSIP ON EXT: True (<DEFAULT>)
DISABLE SCAVENGE MERGING: False (<DEFAULT>)
DISCOVER VIA DNS: True (<DEFAULT>)
CLUSTER DNS: fake.dns (<DEFAULT>)
CLUSTER GOSSIP PORT: 30777 (<DEFAULT>)
GOSSIP SEED: <empty> (<DEFAULT>)
STATS PERIOD SEC: 30 (<DEFAULT>)
CACHED CHUNKS: -1 (<DEFAULT>)
CHUNKS CACHE SIZE: 536871424 (<DEFAULT>)
MAX MEM TABLE SIZE: 1000000 (<DEFAULT>)
DB: /datadrive/eventstore/db (Config File)
MEM DB: False (<DEFAULT>)
SKIP DB VERIFY: False (<DEFAULT>)
RUN PROJECTIONS: All (Config File)
PROJECTION THREADS: 3 (<DEFAULT>)
WORKER THREADS: 5 (<DEFAULT>)
HTTP PREFIXES: <empty> (<DEFAULT>)
ENABLE TRUSTED AUTH: False (<DEFAULT>)
CERTIFICATE STORE LOCATION: <empty> (<DEFAULT>)
CERTIFICATE STORE NAME: <empty> (<DEFAULT>)
CERTIFICATE SUBJECT NAME: <empty> (<DEFAULT>)
CERTIFICATE THUMBPRINT: <empty> (<DEFAULT>)
CERTIFICATE FILE: <empty> (<DEFAULT>)
CERTIFICATE PASSWORD: <empty> (<DEFAULT>)
USE INTERNAL SSL: False (<DEFAULT>)
SSL TARGET HOST: n/a (<DEFAULT>)
SSL VALIDATE SERVER: True (<DEFAULT>)
AUTHENTICATION TYPE: internal (<DEFAULT>)
PREPARE TIMEOUT MS: 2000 (<DEFAULT>)
COMMIT TIMEOUT MS: 2000 (<DEFAULT>)
UNSAFE DISABLE FLUSH TO DISK: False (<DEFAULT>)
GOSSIP INTERVAL MS: 1000 (<DEFAULT>)
GOSSIP ALLOWED DIFFERENCE MS: 60000 (<DEFAULT>)
GOSSIP TIMEOUT MS: 500 (<DEFAULT>)
[PID:40501:001 2015.01.30 21:09:13.419 INFO ProgramBase`1 ] Quorum size set to 1
[PID:40501:001 2015.01.30 21:09:13.427 INFO ProgramBase`1 ] Can't find plugins path: plugins
[PID:40501:001 2015.01.30 21:09:13.461 INFO ProgramBase`1 ]
INSTANCE ID: a326de0e-3a5e-4db1-a748-8423f138bea3
DATABASE: /datadrive/eventstore/db
WRITER CHECKPOINT: 160178116 (0x98C1FC4)
CHASER CHECKPOINT: 160178116 (0x98C1FC4)
EPOCH CHECKPOINT: 160157262 (0x98BCE4E)
TRUNCATE CHECKPOINT: -1 (0xFFFFFFFFFFFFFFFF)
[PID:40501:001 2015.01.30 21:09:13.671 TRACE MessageHierarchy ] MessageHierarchy initialization took 00:00:00.1610596.
[PID:40501:001 2015.01.30 21:09:15.682 TRACE TFChunk ] CACHED TFChunk #0-0 (chunk-000000.000000) in 00:00:00.1568462.
[PID:40501:001 2015.01.30 21:09:15.952 INFO MiniWeb ] Starting MiniWeb for /web/es/js/projections ==> /datadrive/EventStore-OSS-Linux-v3.0.1/projections
[PID:40501:001 2015.01.30 21:09:15.952 INFO MiniWeb ] Starting MiniWeb for /web/es/js/projections/v8/Prelude ==> /datadrive/EventStore-OSS-Linux-v3.0.1/Prelude
[PID:40501:001 2015.01.30 21:09:15.952 INFO MiniWeb ] Starting MiniWeb for /web/es/js/projections/resources ==> /datadrive/EventStore-OSS-Linux-v3.0.1/web-resources/js
[PID:40501:001 2015.01.30 21:09:15.954 TRACE MiniWeb ] Binding MiniWeb to /web/es/js/projections/{*remaining_path}
[PID:40501:001 2015.01.30 21:09:15.954 TRACE MiniWeb ] Binding MiniWeb to /web/es/js/projections/v8/Prelude/{*remaining_path}
[PID:40501:001 2015.01.30 21:09:15.954 TRACE MiniWeb ] Binding MiniWeb to /web/es/js/projections/resources/{*remaining_path}
[PID:40501:001 2015.01.30 21:09:15.968 INFO MiniWeb ] Starting MiniWeb for /web ==> /datadrive/EventStore-OSS-Linux-v3.0.1/clusternode-web
[PID:40501:001 2015.01.30 21:09:15.968 TRACE MiniWeb ] Binding MiniWeb to /web/{*remaining_path}
[PID:40501:001 2015.01.30 21:09:15.970 INFO MiniWeb ] Starting MiniWeb for /web/users ==> /datadrive/EventStore-OSS-Linux-v3.0.1/Users/web
[PID:40501:001 2015.01.30 21:09:15.970 TRACE MiniWeb ] Binding MiniWeb to /web/users/{*remaining_path}
[PID:40501:009 2015.01.30 21:09:16.034 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] SYSTEM INIT...
[PID:40501:009 2015.01.30 21:09:16.078 INFO TcpServerListener ] Starting Normal TCP listening on TCP endpoint: 0.0.0.0:1113.
[PID:40501:014 2015.01.30 21:09:16.101 INFO IndexCommitter ] TableIndex initialization...
[PID:40501:014 2015.01.30 21:09:16.109 INFO IndexCommitter ] ReadIndex building...
[PID:40501:009 2015.01.30 21:09:16.134 INFO HttpAsyncServer ] Starting HTTP server on [http://0.0.0.0:2113/]...
[PID:40501:009 2015.01.30 21:09:16.138 INFO HttpAsyncServer ] HTTP server is up and listening on [http://0.0.0.0:2113/]
[PID:40501:009 2015.01.30 21:09:16.175 TRACE InMemoryBus ] SLOW BUS MSG [MainBus]: SystemInit - 55ms. Handler: HttpService.
[PID:40501:009 2015.01.30 21:09:16.206 TRACE QueuedHandlerAutoRes] SLOW QUEUE MSG [MainQueue]: SystemInit - 204ms. Q: 0/3486.
[PID:40501:009 2015.01.30 21:09:16.206 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] Service 'StorageReader' initialized.
[PID:40501:009 2015.01.30 21:09:16.206 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] Service 'StorageWriter' initialized.
[PID:40501:014 2015.01.30 21:09:17.676 DEBUG IndexCommitter ] ReadIndex Rebuilding: processed 100000 records (76.2%).
[PID:40501:009 2015.01.30 21:09:18.032 TRACE InMemoryBus ] SLOW BUS MSG [MainBus]: EventCommitted - 80ms. Handler: WideningHandler`2.
[PID:40501:009 2015.01.30 21:09:18.032 TRACE QueuedHandlerAutoRes] SLOW QUEUE MSG [MainQueue]: EventCommitted - 80ms. Q: 48150/48150.
[PID:40501:014 2015.01.30 21:09:18.176 DEBUG IndexCommitter ] ReadIndex rebuilding done: total processed 131420 records, time elapsed: 00:00:02.0666010.
[PID:40501:009 2015.01.30 21:09:18.673 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] Service 'StorageChaser' initialized.
[PID:40501:009 2015.01.30 21:09:18.673 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] SYSTEM START...
[PID:40501:009 2015.01.30 21:09:18.677 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] IS UNKNOWN!!! WHOA!!!
[PID:40501:009 2015.01.30 21:09:18.714 DEBUG ElectionsService ] ELECTIONS: STARTING ELECTIONS.
[PID:40501:009 2015.01.30 21:09:18.715 DEBUG ElectionsService ] ELECTIONS: (V=0) SHIFT TO LEADER ELECTION.
[PID:40501:009 2015.01.30 21:09:18.717 DEBUG ElectionsService ] ELECTIONS: (V=0) VIEWCHANGE FROM [0.0.0.0:2112, {a326de0e-3a5e-4db1-a748-8423f138bea3}].
[PID:40501:009 2015.01.30 21:09:18.717 DEBUG ElectionsService ] ELECTIONS: (V=0) MAJORITY OF VIEWCHANGE.
[PID:40501:009 2015.01.30 21:09:18.718 DEBUG ElectionsService ] ELECTIONS: (V=0) SHIFT TO PREPARE PHASE.
[PID:40501:009 2015.01.30 21:09:18.719 DEBUG ElectionsService ] ELECTIONS: (V=0) PREPARE_OK FROM [0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}](L=160177573,W=160178116,C=160178116,E4@160157262:{3075aeda-2a15-4bc1-af9d-ccc308c2b171}).
[PID:40501:009 2015.01.30 21:09:18.720 DEBUG ElectionsService ] ELECTIONS: (V=0) SHIFT TO REG_LEADER.
[PID:40501:009 2015.01.30 21:09:18.727 DEBUG ElectionsService ] ELECTIONS: (V=0) SENDING PROPOSAL CANDIDATE: [0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}](L=160177573,W=160178116,C=160178116,E4@160157262:{3075aeda-2a15-4bc1-af9d-ccc308c2b171}), ME: [0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}](L=160177573,W=160178116,C=160178116,E4@160157262:{3075aeda-2a15-4bc1-af9d-ccc308c2b171}).
[PID:40501:009 2015.01.30 21:09:18.728 DEBUG ElectionsService ] ELECTIONS: (V=0) ACCEPT FROM [0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}] M=[0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}]).
[PID:40501:009 2015.01.30 21:09:18.728 INFO ElectionsService ] ELECTIONS: (V=0) DONE. ELECTED MASTER = [0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}](L=160177573,W=160178116,C=160178116,E4@160157262:{3075aeda-2a15-4bc1-af9d-ccc308c2b171}). ME=[0.0.0.0:2112,{a326de0e-3a5e-4db1-a748-8423f138bea3}](L=160177573,W=160178116,C=160178116,E4@160157262:{3075aeda-2a15-4bc1-af9d-ccc308c2b171}).
[PID:40501:009 2015.01.30 21:09:18.729 TRACE InMemoryBus ] SLOW BUS MSG [MainBus]: StartElections - 48ms. Handler: ElectionsService.
[PID:40501:009 2015.01.30 21:09:18.729 TRACE QueuedHandlerAutoRes] SLOW QUEUE MSG [MainQueue]: StartElections - 48ms. Q: 0/4.
[PID:40501:009 2015.01.30 21:09:18.731 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] PRE-MASTER STATE, WAITING FOR CHASER TO CATCH UP...
[PID:40501:009 2015.01.30 21:09:18.733 INFO ClusterVNodeControll] ========== [0.0.0.0:2112] IS MASTER!!! SPARTA!!!
[PID:40501:007 2015.01.30 21:09:18.828 DEBUG EpochManager ] === Writing E5@160178116:{98dec738-7f11-4d63-aa23-3ecfd799b06b} (previous epoch at 160157262).
[PID:40501:007 2015.01.30 21:09:18.884 DEBUG EpochManager ] === Update Last Epoch E5@160178116:{98dec738-7f11-4d63-aa23-3ecfd799b06b} (previous epoch at 160157262).
[PID:40501:006 2015.01.30 21:09:18.972 TRACE MonitoringService ] Created stats stream '$stats-0.0.0.0:2113', code = WrongExpectedVersion
Sign up for free to join this conversation on GitHub. Already have an account? Sign in to comment