results for unir-865d54db67-2wtmg

output-logs.txt

find . -name console.log | grep `ls -d ./undefined* | tail -1` | xargs cat
2018-05-08 16:11:18.546 [info] <0.33.0> Application lager started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.552 [info] <0.33.0> Application types started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.554 [info] <0.33.0> Application acceptor_pool started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.570 [info] <0.33.0> Application asn1 started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.570 [info] <0.33.0> Application public_key started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.639 [info] <0.33.0> Application ssl started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.645 [info] <0.33.0> Application rand_compat started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.657 [info] <0.33.0> Application quickrand started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.657 [info] <0.33.0> Application uuid started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.667 [info] <0.185.0>@partisan_config:init:58 Using node name: 'node_3@127.0.0.1'
2018-05-08 16:11:18.677 [info] <0.187.0>@partisan_config:get_node_address:168 Resolving "127.0.0.1"...
2018-05-08 16:11:18.678 [info] <0.187.0>@partisan_config:get_node_address:171 Resolved "node_3@127.0.0.1" to {127,0,0,1}
2018-05-08 16:11:18.679 [info] <0.185.0>@partisan_config:get_node_address:188 Resolved "127.0.0.1" to {127,0,0,1}
2018-05-08 16:11:18.834 [info] <0.33.0> Application partisan started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.839 [info] <0.33.0> Application gen_fsm_compat started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.848 [info] <0.33.0> Application riak_sysmon started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.877 [info] <0.33.0> Application os_mon started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.886 [info] <0.33.0> Application basho_stats started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.890 [info] <0.33.0> Application eleveldb started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.895 [info] <0.33.0> Application pbkdf2 started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.896 [info] <0.33.0> Application poolboy started on node 'node_3@127.0.0.1'
2018-05-08 16:11:18.952 [info] <0.266.0>@exometer_report:do_start_reporters:613 Starting reporters with []
2018-05-08 16:11:19.023 [info] <0.33.0> Application clique started on node 'node_3@127.0.0.1'
2018-05-08 16:11:19.056 [info] <0.33.0> Application folsom started on node 'node_3@127.0.0.1'
2018-05-08 16:11:19.103 [info] <0.284.0>@riak_core_partisan_utils:configure_dispatch:145 Configuring partisan dispatch: true
2018-05-08 16:11:19.312 [warning] <0.300.0>@riak_core_ring_manager:reload_ring:380 No ring file available.
2018-05-08 16:11:19.878 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,vnode_routing} = proxy
2018-05-08 16:11:19.884 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,staged_joins} = true
2018-05-08 16:11:19.905 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,resizable_ring} = true
2018-05-08 16:11:19.931 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,fold_req_version} = v2
2018-05-08 16:11:19.943 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,security} = true
2018-05-08 16:11:19.953 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,bucket_types} = true
2018-05-08 16:11:19.960 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,net_ticktime} = true
2018-05-08 16:11:20.195 [info] <0.33.0> Application riak_core started on node 'node_3@127.0.0.1'
2018-05-08 16:11:20.204 [info] <0.33.0> Application setup started on node 'node_3@127.0.0.1'
2018-05-08 16:11:31.625 [info] <0.2350.0>@riak_core_partisan_utils:join:100 Starting join from partisan utils from 'node_3@127.0.0.1' to 'node_1@127.0.0.1'
2018-05-08 16:11:32.694 [info] <0.2350.0>@riak_core_partisan_utils:join:106 Finishing join from 'node_3@127.0.0.1' to 'node_1@127.0.0.1'
2018-05-08 16:11:32.702 [info] <0.2350.0>@riak_core_partisan_utils:join:100 Starting join from partisan utils from 'node_3@127.0.0.1' to 'node_3@127.0.0.1'
2018-05-08 16:11:32.756 [info] <0.2350.0>@riak_core_partisan_utils:join:106 Finishing join from 'node_3@127.0.0.1' to 'node_3@127.0.0.1'
2018-05-08 16:11:42.339 [info] <0.300.0>@riak_core_gossip:log_node_changed:357 'node_3@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:11:57.644 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.6.0> [{name,erl_prim_loader},{initial_call,{erlang,apply,2}},{almost_current_function,{erl_prim_loader,loop,3}},{message_queue_len,0},{dictionary,[]}] [{timeout,61},{in,{erl_prim_loader,loop,3}},{out,{prim_file,drv_get_response,1}}]
2018-05-08 16:12:20.075 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.6.0> [{name,erl_prim_loader},{initial_call,{erlang,apply,2}},{almost_current_function,{erl_prim_loader,loop,3}},{message_queue_len,0},{dictionary,[]}] [{timeout,53},{in,{erl_prim_loader,loop,3}},{out,{prim_file,drv_get_response,1}}]
2018-05-08 16:12:30.153 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.3430.0> [{initial_call,{partisan_peer_service_client,init,1}},{almost_current_function,{gen_server,loop,7}},{message_queue_len,0},{dictionary,[{{partisan_peer_service_client,listen_addr},#{ip => {127,0,0,1},port => 41245}},{{partisan_peer_service_client,peer},#{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1}},{'$initial_call',{partisan_peer_service_client,init,1}},{'$ancestors',[partisan_default_peer_service_manager,partisan_sup,<0.184.0>]},{{partisan_peer_service_client,channel},{monotonic,gossip}},{last_transmission_time,-576460674640},{{partisan_peer_service_client,from},<0.220.0>}]}] [{timeout,58},{in,{partisan_util,term_to_iolist_,1}},{out,{gen_server,loop,7}}]
2018-05-08 16:13:38.709 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.299.0> [{name,riak_core_ring_events},{initial_call,{gen_event,init_it,6}},{almost_current_function,{gen_event,fetch_msg,6}},{message_queue_len,0},{dictionary,[{'$initial_call',{gen_event,init_it,6}},{'$ancestors',[riak_core_sup,<0.283.0>]}]}] [{timeout,66},{in,{riak_core_ring_handler,'-maybe_stop_vnode_proxies/1-lc$^3/1-3-',2}},{out,{gen_event,fetch_msg,6}}]
2018-05-08 16:13:39.848 [error] <0.220.0>@partisan_default_peer_service_manager:do_send_message:933 Node 'node_1@127.0.0.1' was connected, but is now disconnected!
2018-05-08 16:13:40.301 [warning] <0.5031.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:41.318 [warning] <0.5032.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:42.393 [warning] <0.5033.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:42.393 [warning] <0.5034.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 58099}],name => 'node_2@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:43.423 [warning] <0.5046.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:43.435 [warning] <0.5049.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 58099}],name => 'node_2@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:43.567 [info] <0.283.0>@riak_core_app:stop:47 Stopped  application riak_core.
2018-05-08 16:11:14.995 [info] <0.33.0> Application lager started on node 'node_1@127.0.0.1'
2018-05-08 16:11:14.997 [info] <0.33.0> Application types started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.000 [info] <0.33.0> Application acceptor_pool started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.015 [info] <0.33.0> Application asn1 started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.015 [info] <0.33.0> Application public_key started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.091 [info] <0.33.0> Application ssl started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.093 [info] <0.33.0> Application rand_compat started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.098 [info] <0.33.0> Application quickrand started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.098 [info] <0.33.0> Application uuid started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.106 [info] <0.187.0>@partisan_config:init:58 Using node name: 'node_1@127.0.0.1'
2018-05-08 16:11:15.125 [info] <0.189.0>@partisan_config:get_node_address:168 Resolving "127.0.0.1"...
2018-05-08 16:11:15.125 [info] <0.189.0>@partisan_config:get_node_address:171 Resolved "node_1@127.0.0.1" to {127,0,0,1}
2018-05-08 16:11:15.125 [info] <0.187.0>@partisan_config:get_node_address:188 Resolved "127.0.0.1" to {127,0,0,1}
2018-05-08 16:11:15.284 [info] <0.33.0> Application partisan started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.291 [info] <0.33.0> Application gen_fsm_compat started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.309 [info] <0.33.0> Application riak_sysmon started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.347 [info] <0.33.0> Application os_mon started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.352 [info] <0.33.0> Application basho_stats started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.355 [info] <0.33.0> Application eleveldb started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.356 [info] <0.33.0> Application pbkdf2 started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.358 [info] <0.33.0> Application poolboy started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.416 [info] <0.266.0>@exometer_report:do_start_reporters:613 Starting reporters with []
2018-05-08 16:11:15.417 [info] <0.33.0> Application exometer_core started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.465 [info] <0.33.0> Application clique started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.490 [info] <0.33.0> Application folsom started on node 'node_1@127.0.0.1'
2018-05-08 16:11:15.532 [info] <0.284.0>@riak_core_partisan_utils:configure_dispatch:145 Configuring partisan dispatch: true
2018-05-08 16:11:15.616 [warning] <0.300.0>@riak_core_ring_manager:reload_ring:380 No ring file available.
2018-05-08 16:11:15.798 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.310.0>  [{timeout,85},{in,{code_server,call,1}},{out,{code_server,'-handle_on_load/5-fun-0-',1}}]
2018-05-08 16:11:15.971 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,vnode_routing} = proxy
2018-05-08 16:11:15.982 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,staged_joins} = true
2018-05-08 16:11:15.991 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,resizable_ring} = true
2018-05-08 16:11:16.001 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,fold_req_version} = v2
2018-05-08 16:11:16.010 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,security} = true
2018-05-08 16:11:16.021 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,bucket_types} = true
2018-05-08 16:11:16.030 [info] <0.317.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,net_ticktime} = true
2018-05-08 16:11:16.312 [info] <0.33.0> Application riak_core started on node 'node_1@127.0.0.1'
2018-05-08 16:11:16.401 [info] <0.33.0> Application setup started on node 'node_1@127.0.0.1'
2018-05-08 16:11:26.596 [error] <0.220.0>@partisan_default_peer_service_manager:do_send_message:940 Node 'node_2@127.0.0.1' is not yet connected during send!
2018-05-08 16:11:29.118 [info] <0.300.0>@riak_core_gossip:log_node_added:360 'node_2@127.0.0.1' joined cluster with status 'valid'
2018-05-08 16:11:32.809 [error] <0.220.0>@partisan_default_peer_service_manager:do_send_message:940 Node 'node_3@127.0.0.1' is not yet connected during send!
2018-05-08 16:11:40.664 [info] <0.300.0>@riak_core_gossip:log_node_added:360 'node_3@127.0.0.1' joined cluster with status 'joining'
2018-05-08 16:11:42.000 [info] <0.300.0>@riak_core_gossip:log_node_changed:357 'node_3@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:11:57.713 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.3513.0> [{initial_call,{partisan_peer_service_client,init,1}},{almost_current_function,{gen_server,loop,7}},{message_queue_len,0},{dictionary,[{{partisan_peer_service_client,peer},#{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 43877}],name => 'node_3@127.0.0.1',parallelism => 1}},{{partisan_peer_service_client,from},<0.220.0>},{{partisan_peer_service_client,listen_addr},#{ip => {127,0,0,1},port => 43877}},{{partisan_peer_service_client,channel},{monotonic,gossip}},{'$initial_call',{partisan_peer_service_client,init,1}},{'$ancestors',[partisan_default_peer_service_manager,partisan_sup,<0.186.0>]},{last_transmission_time,-576460704936}]}] [{timeout,76},{in,{partisan_util,term_to_iolist_,1}},{out,{gen_server,loop,7}}]
2018-05-08 16:11:57.848 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.300.0> [{name,riak_core_ring_manager},{initial_call,{riak_core_ring_manager,init,1}},{almost_current_function,{riak_core_claimant,'-handle_down_nodes/2-lc$^0/1-0-',4}},{message_queue_len,0},{dictionary,[{rand_seed,{#{bits => 58,jump => #Fun<rand.8.15449617>,next => #Fun<rand.5.15449617>,type => exrop,uniform => #Fun<rand.6.15449617>,uniform_n => #Fun<rand.7.15449617>,weak_low_bits => 1},[36894271581324898|268855263524445402]}},{'$initial_call',{riak_core_ring_manager,init,1}},{'$ancestors',[riak_core_sup,<0.283.0>]}]}] [{timeout,104},{in,{riak_core_claimant,'-transfer_ownership/2-fun-0-',2}},{out,{lists,foldl,3}}]
2018-05-08 16:12:08.447 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.300.0> [{name,riak_core_ring_manager},{initial_call,{riak_core_ring_manager,init,1}},{almost_current_function,{riak_core_claimant,'-handle_down_nodes/2-lc$^1/1-1-',2}},{message_queue_len,0},{dictionary,[{rand_seed,{#{bits => 58,jump => #Fun<rand.8.15449617>,next => #Fun<rand.5.15449617>,type => exrop,uniform => #Fun<rand.6.15449617>,uniform_n => #Fun<rand.7.15449617>,weak_low_bits => 1},[36894271581324898|268855263524445402]}},{'$initial_call',{riak_core_ring_manager,init,1}},{'$ancestors',[riak_core_sup,<0.283.0>]}]}] [{timeout,53},{in,{riak_core_ring,index_owner,2}},{out,{riak_core_ring,index_owner,2}}]
2018-05-08 16:12:20.075 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.6.0> [{name,erl_prim_loader},{initial_call,{erlang,apply,2}},{almost_current_function,{erl_prim_loader,loop,3}},{message_queue_len,0},{dictionary,[]}] [{timeout,53},{in,{erl_prim_loader,loop,3}},{out,{prim_file,drv_get_response,1}}]
2018-05-08 16:12:26.419 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.300.0> [{name,riak_core_ring_manager},{initial_call,{riak_core_ring_manager,init,1}},{almost_current_function,{riak_core_claimant,'-transfer_ownership/2-fun-1-',3}},{message_queue_len,0},{dictionary,[{rand_seed,{#{bits => 58,jump => #Fun<rand.8.15449617>,next => #Fun<rand.5.15449617>,type => exrop,uniform => #Fun<rand.6.15449617>,uniform_n => #Fun<rand.7.15449617>,weak_low_bits => 1},[36894271581324898|268855263524445402]}},{'$initial_call',{riak_core_ring_manager,init,1}},{'$ancestors',[riak_core_sup,<0.283.0>]}]}] [{timeout,62},{in,{lists,'-filter/2-lc$^0/1-0-',2}},{out,{lists,'-filter/2-lc$^0/1-0-',2}}]
2018-05-08 16:13:01.231 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_gc <0.318.0> [{name,riak_core_gossip},{initial_call,{riak_core_gossip,init,1}},{almost_current_function,{gen,do_call,4}},{message_queue_len,7},{dictionary,[{rand_seed,{#{bits => 58,jump => #Fun<rand.8.15449617>,next => #Fun<rand.5.15449617>,type => exrop,uniform => #Fun<rand.6.15449617>,uniform_n => #Fun<rand.7.15449617>,weak_low_bits => 1},[155542119025520804|16224277867565409]}},{'$initial_call',{riak_core_gossip,init,1}},{'$ancestors',[riak_core_sup,<0.283.0>]}]}] [{timeout,71},{old_heap_block_size,121536},{heap_block_size,196650},{mbuf_size,0},{stack_size,21},{old_heap_size,15963},{heap_size,47914}]
2018-05-08 16:13:10.467 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.5712.0> [{initial_call,{riak_core_vnode,init,1}},{almost_current_function,{gen,do_call,4}},{message_queue_len,0},{dictionary,[{rand_seed,{#{bits => 58,jump => #Fun<rand.8.15449617>,next => #Fun<rand.5.15449617>,type => exrop,uniform => #Fun<rand.6.15449617>,uniform_n => #Fun<rand.7.15449617>,weak_low_bits => 1},[267873783160864123|36722089738843839]}},{'$initial_call',{riak_core_vnode,init,1}},{'$ancestors',[riak_core_vnode_sup,riak_core_sup,<0.283.0>]}]}] [{timeout,73},{in,{gen_fsm_compat,loop,8}},{out,{gen,do_call,4}}]
2018-05-08 16:13:38.703 [info] <0.245.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.299.0> [{name,riak_core_ring_events},{initial_call,{gen_event,init_it,6}},{almost_current_function,{gen_event,fetch_msg,6}},{message_queue_len,0},{dictionary,[{'$initial_call',{gen_event,init_it,6}},{'$ancestors',[riak_core_sup,<0.283.0>]}]}] [{timeout,71},{in,{riak_core_ring_handler,'-maybe_stop_vnode_proxies/1-lc$^3/1-3-',2}},{out,{gen_event,fetch_msg,6}}]
2018-05-08 16:13:39.427 [info] <0.283.0>@riak_core_app:stop:47 Stopped  application riak_core.
2018-05-08 16:11:16.906 [info] <0.33.0> Application lager started on node 'node_2@127.0.0.1'
2018-05-08 16:11:16.918 [info] <0.33.0> Application types started on node 'node_2@127.0.0.1'
2018-05-08 16:11:16.922 [info] <0.33.0> Application acceptor_pool started on node 'node_2@127.0.0.1'
2018-05-08 16:11:16.982 [info] <0.33.0> Application asn1 started on node 'node_2@127.0.0.1'
2018-05-08 16:11:16.982 [info] <0.33.0> Application public_key started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.079 [info] <0.33.0> Application ssl started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.083 [info] <0.33.0> Application rand_compat started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.095 [info] <0.33.0> Application quickrand started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.095 [info] <0.33.0> Application uuid started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.111 [info] <0.188.0>@partisan_config:init:58 Using node name: 'node_2@127.0.0.1'
2018-05-08 16:11:17.140 [info] <0.190.0>@partisan_config:get_node_address:168 Resolving "127.0.0.1"...
2018-05-08 16:11:17.140 [info] <0.190.0>@partisan_config:get_node_address:171 Resolved "node_2@127.0.0.1" to {127,0,0,1}
2018-05-08 16:11:17.140 [info] <0.188.0>@partisan_config:get_node_address:188 Resolved "127.0.0.1" to {127,0,0,1}
2018-05-08 16:11:17.465 [info] <0.33.0> Application partisan started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.475 [info] <0.33.0> Application gen_fsm_compat started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.493 [info] <0.33.0> Application riak_sysmon started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.548 [info] <0.33.0> Application os_mon started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.562 [info] <0.33.0> Application basho_stats started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.566 [info] <0.33.0> Application eleveldb started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.571 [info] <0.33.0> Application pbkdf2 started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.574 [info] <0.33.0> Application poolboy started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.661 [info] <0.267.0>@exometer_report:do_start_reporters:613 Starting reporters with []
2018-05-08 16:11:17.661 [info] <0.33.0> Application exometer_core started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.727 [info] <0.33.0> Application clique started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.750 [info] <0.33.0> Application folsom started on node 'node_2@127.0.0.1'
2018-05-08 16:11:17.805 [info] <0.285.0>@riak_core_partisan_utils:configure_dispatch:145 Configuring partisan dispatch: true
2018-05-08 16:11:17.867 [warning] <0.301.0>@riak_core_ring_manager:reload_ring:380 No ring file available.
2018-05-08 16:11:18.141 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,vnode_routing} = proxy
2018-05-08 16:11:18.151 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,staged_joins} = true
2018-05-08 16:11:18.162 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,resizable_ring} = true
2018-05-08 16:11:18.170 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,fold_req_version} = v2
2018-05-08 16:11:18.178 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,security} = true
2018-05-08 16:11:18.191 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,bucket_types} = true
2018-05-08 16:11:18.198 [info] <0.318.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,net_ticktime} = true
2018-05-08 16:11:18.290 [info] <0.33.0> Application riak_core started on node 'node_2@127.0.0.1'
2018-05-08 16:11:18.295 [info] <0.33.0> Application setup started on node 'node_2@127.0.0.1'
2018-05-08 16:11:25.385 [info] <0.1375.0>@riak_core_partisan_utils:join:100 Starting join from partisan utils from 'node_2@127.0.0.1' to 'node_1@127.0.0.1'
2018-05-08 16:11:26.446 [info] <0.1375.0>@riak_core_partisan_utils:join:106 Finishing join from 'node_2@127.0.0.1' to 'node_1@127.0.0.1'
2018-05-08 16:11:26.472 [info] <0.1375.0>@riak_core_partisan_utils:join:100 Starting join from partisan utils from 'node_2@127.0.0.1' to 'node_2@127.0.0.1'
2018-05-08 16:11:26.506 [info] <0.1375.0>@riak_core_partisan_utils:join:106 Finishing join from 'node_2@127.0.0.1' to 'node_2@127.0.0.1'
2018-05-08 16:11:29.160 [info] <0.301.0>@riak_core_gossip:log_node_changed:357 'node_2@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:11:41.775 [info] <0.301.0>@riak_core_gossip:log_node_added:360 'node_3@127.0.0.1' joined cluster with status 'joining'
2018-05-08 16:11:42.055 [info] <0.246.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule #Port<0.720> name tcp_inet [{links,[<0.75.0>]},{id,5760},{connected,<0.75.0>},{input,40125},{output,44},{os_pid,undefined},{queue_size,0}] [{timeout,58},{port_op,dist_cmd}]
2018-05-08 16:11:42.238 [info] <0.301.0>@riak_core_gossip:log_node_changed:357 'node_3@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:11:42.749 [info] <0.246.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.1379.0> [{initial_call,{partisan_peer_service_client,init,1}},{almost_current_function,{gen_server,loop,7}},{message_queue_len,0},{dictionary,[{{partisan_peer_service_client,from},<0.221.0>},{last_transmission_time,-576460720999},{{partisan_peer_service_client,listen_addr},#{ip => {127,0,0,1},port => 41245}},{'$initial_call',{partisan_peer_service_client,init,1}},{{partisan_peer_service_client,peer},#{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1}},{'$ancestors',[partisan_default_peer_service_manager,partisan_sup,<0.187.0>]},{{partisan_peer_service_client,channel},{monotonic,gossip}}]}] [{timeout,78},{in,{partisan_util,term_to_iolist_,1}},{out,{gen_server,loop,7}}]
2018-05-08 16:12:40.985 [info] <0.246.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule #Port<0.720> name tcp_inet [{links,[<0.75.0>]},{id,5760},{connected,<0.75.0>},{input,84134},{output,44},{os_pid,undefined},{queue_size,0}] [{timeout,59},{port_op,dist_cmd}]
2018-05-08 16:13:40.268 [warning] <0.3845.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:41.295 [warning] <0.3846.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 41245}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:13:41.463 [info] <0.284.0>@riak_core_app:stop:47 Stopped  application riak_core.

output-proper.txt

===> Linking _build/default/plugins/rebar_erl_vsn to _build/test/plugins/rebar_erl_vsn
===> Linking _build/default/plugins/rebar3_proper to _build/test/plugins/rebar3_proper
===> Linking _build/default/plugins/rebar3_run to _build/test/plugins/rebar3_run
===> Verifying dependencies...
===> Fetching proper ({pkg,<<"proper">>,<<"1.2.0">>})
===> Version cached at /root/.cache/rebar3/hex/default/packages/proper-1.2.0.tar is up to date, reusing it
===> Fetching recon ({pkg,<<"recon">>,<<"2.3.5">>})
===> Downloaded package, caching at /root/.cache/rebar3/hex/default/packages/recon-2.3.5.tar
===> Linking _build/default/lib/exometer_core to _build/test/lib/exometer_core
===> Linking _build/default/lib/lager to _build/test/lib/lager
===> Linking _build/default/lib/lasp_bench to _build/test/lib/lasp_bench
===> Linking _build/default/lib/partisan to _build/test/lib/partisan
===> Linking _build/default/lib/pbkdf2 to _build/test/lib/pbkdf2
===> Linking _build/default/lib/poolboy to _build/test/lib/poolboy
===> Linking _build/default/lib/riak_core to _build/test/lib/riak_core
===> Linking _build/default/lib/riak_core_partisan_utils to _build/test/lib/riak_core_partisan_utils
===> Linking _build/default/lib/riak_ensemble to _build/test/lib/riak_ensemble
===> Linking _build/default/plugins/pc to _build/test/plugins/pc
===> Linking _build/default/lib/acceptor_pool to _build/test/lib/acceptor_pool
===> Linking _build/default/lib/basho_stats to _build/test/lib/basho_stats
===> Linking _build/default/lib/blume to _build/test/lib/blume
===> Linking _build/default/lib/chash to _build/test/lib/chash
===> Linking _build/default/lib/clique to _build/test/lib/clique
===> Linking _build/default/lib/cuttlefish to _build/test/lib/cuttlefish
===> Linking _build/default/lib/eleveldb to _build/test/lib/eleveldb
===> Linking _build/default/lib/folsom to _build/test/lib/folsom
===> Linking _build/default/lib/gen_fsm_compat to _build/test/lib/gen_fsm_compat
===> Linking _build/default/lib/getopt to _build/test/lib/getopt
===> Linking _build/default/lib/goldrush to _build/test/lib/goldrush
===> Linking _build/default/lib/jam to _build/test/lib/jam
===> Linking _build/default/lib/parse_trans to _build/test/lib/parse_trans
===> Linking _build/default/lib/rand_compat to _build/test/lib/rand_compat
===> Linking _build/default/lib/riak_sysmon to _build/test/lib/riak_sysmon
===> Linking _build/default/lib/setup to _build/test/lib/setup
===> Linking _build/default/lib/time_compat to _build/test/lib/time_compat
===> Linking _build/default/lib/types to _build/test/lib/types
===> Linking _build/default/lib/uuid to _build/test/lib/uuid
===> Linking _build/default/lib/bear to _build/test/lib/bear
===> Linking _build/default/lib/edown to _build/test/lib/edown
===> Linking _build/default/lib/meck to _build/test/lib/meck
===> Linking _build/default/lib/quickrand to _build/test/lib/quickrand
===> Compiling proper
make: 'include/compile_flags.hrl' is up to date.
/opt/unir/_build/test/lib/proper/src/proper_typeserver.erl:553: Warning: erlang:get_stacktrace/0 used following a 'try' expression may stop working in a future release. (Use it inside 'try'.)
/opt/unir/_build/test/lib/proper/src/proper_typeserver.erl:556: Warning: erlang:get_stacktrace/0 used following a 'try' expression may stop working in a future release. (Use it inside 'try'.)
_build/test/lib/proper/src/proper_typeserver.erl:553: Warning: erlang:get_stacktrace/0 used following a 'try' expression may stop working in a future release. (Use it inside 'try'.)
_build/test/lib/proper/src/proper_typeserver.erl:556: Warning: erlang:get_stacktrace/0 used following a 'try' expression may stop working in a future release. (Use it inside 'try'.)

===> Compiling quickrand
===> Compiling uuid
===> Compiling types
===> Compiling time_compat
===> Compiling rand_compat
===> Compiling acceptor_pool
===> Compiling partisan
===> Compiling riak_core_partisan_utils
===> Compiling eleveldb
make: Nothing to be done for 'all'.
make: Nothing to be done for 'tools'.
===> Compiling c_src/eleveldb.cc
===> Compiling c_src/refobjects.cc
===> Compiling c_src/workitems.cc
===> Linking priv/eleveldb.so
===> Compiling getopt
===> Compiling cuttlefish
===> Building escript...
===> Compiling riak_ensemble
===> Linking priv/riak_ensemble_drv.so
===> Compiling chash
===> Compiling basho_stats
===> Compiling edown
===> Compiling setup
/usr/local/bin/rebar skip_deps=true escriptize
==> setup (escriptize)
===> Compiling gen_fsm_compat
===> Compiling poolboy
===> Compiling pbkdf2
===> Compiling parse_trans
===> Compiling exometer_core
===> Compiling clique
===> Compiling blume
===> Compiling riak_core
===> Compiling lasp_bench
===> Compiling recon
===> Compiling unir
src/unir_get_fsm.erl:58: Warning: gen_fsm:start_link/3 is deprecated and will be removed in a future release; use gen_statem:start_link/3

src/unir_ping_fsm.erl:57: Warning: gen_fsm:start_link/3 is deprecated and will be removed in a future release; use gen_statem:start_link/3

src/unir_put_fsm.erl:59: Warning: gen_fsm:start_link/3 is deprecated and will be removed in a future release; use gen_statem:start_link/3

_build/test/lib/unir/test/support.erl:25: Warning: export_all flag enabled - all functions will be exported

_build/test/lib/unir/test/prop_unir.erl:11: Warning: export_all flag enabled - all functions will be exported

_build/test/lib/unir/test/functionality_SUITE.erl:36: Warning: export_all flag enabled - all functions will be exported

_build/test/lib/unir/test/throughput_SUITE.erl:36: Warning: export_all flag enabled - all functions will be exported

test/support.erl:25: Warning: export_all flag enabled - all functions will be exported

test/prop_unir.erl:11: Warning: export_all flag enabled - all functions will be exported

test/functionality_SUITE.erl:36: Warning: export_all flag enabled - all functions will be exported

test/throughput_SUITE.erl:36: Warning: export_all flag enabled - all functions will be exported

===> Testing prop_unir:prop_sequential()
16:11:10.469 [info] Using "node_1@127.0.0.1" as name, since running >= 20.0
16:11:10.469 [info] Starting node: 'node_1@127.0.0.1'
16:11:10.469 [info] Application lager started on node 'runner@127.0.0.1'
16:11:11.636 [info] Node started: 'node_1@127.0.0.1'
16:11:11.636 [info] Using "node_2@127.0.0.1" as name, since running >= 20.0
16:11:11.636 [info] Starting node: 'node_2@127.0.0.1'
16:11:12.704 [info] Node started: 'node_2@127.0.0.1'
16:11:12.704 [info] Using "node_3@127.0.0.1" as name, since running >= 20.0
16:11:12.704 [info] Starting node: 'node_3@127.0.0.1'
16:11:13.766 [info] Node started: 'node_3@127.0.0.1'
16:11:26.558 [info] Issuing normal join from 'node_2@127.0.0.1' to 'node_1@127.0.0.1': ok
16:11:32.796 [info] Issuing normal join from 'node_3@127.0.0.1' to 'node_1@127.0.0.1': ok
16:11:32.796 [info] Waiting for nodes to be ready...
16:11:32.796 [info] Waiting for node 'node_1@127.0.0.1' to be ready...
16:11:32.798 [info] Waiting for node 'node_2@127.0.0.1' to be ready...
16:11:32.804 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:33.810 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:34.813 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:35.815 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:36.826 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:37.828 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:38.830 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:39.843 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:40.849 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:41.861 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:42.869 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:11:42.876 [info] All nodes ready!
16:11:42.876 [info] Waiting for ownership agreement...
16:13:28.793 [info] Waiting for handoff...
16:13:28.793 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:28.882 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:29.885 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:29.950 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:30.953 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:32.865 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:33.866 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:33.877 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:34.878 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:34.885 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:35.886 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:35.939 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:36.940 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:36.952 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:37.953 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:37.963 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:13:38.965 [info] Wait until no pending changes on nodes ['node_1@127.0.0.1','node_2@127.0.0.1','node_3@127.0.0.1']
16:13:38.995 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [true,true,true]
16:13:38.998 [info] No pending changes remain!
16:13:38.998 [info] Waiting for ring convergence...
16:13:39.048 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:13:39.048 [info] read_object: node node_3 key <<"key">>
16:13:39.129 [info] read_object: returned key <<"key">> value not_found
16:13:39.129 [info] read_object: object wasn't written yet, not_found OK

----------------------------------------------------
2018-05-08 16:13:39.340
Stopping node: node_1

Warning: ct_logs not started
Stopping node: node_116:13:39.343 [info] Using "node_1@127.0.0.1" as name, since running >= 20.0

----------------------------------------------------
2018-05-08 16:13:41.354
Stopping node: node_2

Warning: ct_logs not started
Stopping node: node_216:13:41.355 [info] Using "node_2@127.0.0.1" as name, since running >= 20.0

----------------------------------------------------
2018-05-08 16:13:43.360
Stopping node: node_3

Warning: ct_logs not started
Stopping node: node_316:13:43.360 [info] Using "node_3@127.0.0.1" as name, since running >= 20.0
.16:13:45.364 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:13:45.390 [info] Using "node_1@127.0.0.1" as name, since running >= 20.0
16:13:45.390 [info] Starting node: 'node_1@127.0.0.1'
!
Failed: After 2 test(s).
An exception was raised: exit:{test_case_failed,{error,boot_timeout,'node_1@127.0.0.1'}}.
Stacktrace: [{lists,map,2,[{file,"lists.erl"},{line,1239}]},
             {support,start,3,
                      [{file,"/opt/unir/test/support.erl"},{line,117}]},
             {prop_unir,start_nodes,0,
                        [{file,"/opt/unir/test/prop_unir.erl"},{line,307}]},
             {prop_unir,'-prop_sequential/0-fun-2-',1,
                        [{file,"/opt/unir/test/prop_unir.erl"},{line,32}]},
             {proper,apply_args,3,
                     [{file,"/opt/unir/_build/test/lib/proper/src/proper.erl"},
                      {line,1353}]},
             {proper,perform,7,
                     [{file,"/opt/unir/_build/test/lib/proper/src/proper.erl"},
                      {line,1146}]},
             {proper,inner_test,2,
                     [{file,"/opt/unir/_build/test/lib/proper/src/proper.erl"},
                      {line,1028}]}].
[]

Shrinking 16:13:48.447 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:13:48.449 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:13:48.456 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:13:48.460 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:13:48.485 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
(0 time(s))
[]
===> 
0/1 properties passed, 1 failed
===> Failed test cases:
prop_unir:prop_sequential() -> false

rebar3_proper-counterexamples.consult

{prop_unir,prop_sequential,[[]]}.