results for unir-865d54db67-278d5

output-logs.txt

find . -name console.log | grep `ls -d ./undefined* | tail -1` | xargs cat
2018-05-08 16:20:16.227 [info] <0.33.0> Application lager started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.241 [info] <0.33.0> Application types started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.245 [info] <0.33.0> Application acceptor_pool started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.274 [info] <0.33.0> Application asn1 started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.274 [info] <0.33.0> Application public_key started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.331 [info] <0.33.0> Application ssl started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.334 [info] <0.33.0> Application rand_compat started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.339 [info] <0.33.0> Application quickrand started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.339 [info] <0.33.0> Application uuid started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.347 [info] <0.191.0>@partisan_config:init:58 Using node name: 'node_3@127.0.0.1'
2018-05-08 16:20:16.357 [info] <0.193.0>@partisan_config:get_node_address:168 Resolving "127.0.0.1"...
2018-05-08 16:20:16.357 [info] <0.193.0>@partisan_config:get_node_address:171 Resolved "node_3@127.0.0.1" to {127,0,0,1}
2018-05-08 16:20:16.357 [info] <0.191.0>@partisan_config:get_node_address:188 Resolved "127.0.0.1" to {127,0,0,1}
2018-05-08 16:20:16.496 [info] <0.33.0> Application partisan started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.500 [info] <0.33.0> Application gen_fsm_compat started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.507 [info] <0.33.0> Application riak_sysmon started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.538 [info] <0.33.0> Application os_mon started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.552 [info] <0.33.0> Application basho_stats started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.561 [info] <0.33.0> Application eleveldb started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.563 [info] <0.33.0> Application pbkdf2 started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.567 [info] <0.33.0> Application poolboy started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.640 [info] <0.270.0>@exometer_report:do_start_reporters:613 Starting reporters with []
2018-05-08 16:20:16.640 [info] <0.33.0> Application exometer_core started on node 'node_3@127.0.0.1'
2018-05-08 16:20:16.777 [info] <0.288.0>@riak_core_partisan_utils:configure_dispatch:145 Configuring partisan dispatch: true
2018-05-08 16:20:16.843 [warning] <0.304.0>@riak_core_ring_manager:reload_ring:380 No ring file available.
2018-05-08 16:20:17.149 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,vnode_routing} = proxy
2018-05-08 16:20:17.157 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,staged_joins} = true
2018-05-08 16:20:17.166 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,resizable_ring} = true
2018-05-08 16:20:17.180 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,fold_req_version} = v2
2018-05-08 16:20:17.185 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,security} = true
2018-05-08 16:20:17.190 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,bucket_types} = true
2018-05-08 16:20:17.194 [info] <0.321.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,net_ticktime} = true
2018-05-08 16:20:17.304 [info] <0.33.0> Application riak_core started on node 'node_3@127.0.0.1'
2018-05-08 16:20:17.311 [info] <0.33.0> Application setup started on node 'node_3@127.0.0.1'
2018-05-08 16:20:28.490 [info] <0.3430.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:20:29.522 [info] <0.3430.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:20:29.526 [info] <0.3430.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:20:29.552 [info] <0.3430.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:20:39.725 [info] <0.304.0>@riak_core_gossip:log_node_changed:357 'node_3@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:22:16.540 [info] <0.92.0> alarm_handler: {set,{system_memory_high_watermark,[]}}
2018-05-08 16:22:47.680 [info] <0.249.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.303.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.287.0>]}]}] [{timeout,96},{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:22:49.987 [warning] <0.5334.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 56134}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:51.004 [warning] <0.5336.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 56134}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:52.019 [warning] <0.5337.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 37284}],name => 'node_2@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:52.021 [warning] <0.5338.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 56134}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:53.028 [warning] <0.5340.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 37284}],name => 'node_2@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:53.028 [warning] <0.5341.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 56134}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:53.275 [info] <0.287.0>@riak_core_app:stop:47 Stopped  application riak_core.
2018-05-08 16:22:53.393 [info] <0.92.0> alarm_handler: {clear,system_memory_high_watermark}
2018-05-08 16:20:13.648 [info] <0.33.0> Application lager started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.659 [info] <0.33.0> Application types started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.663 [info] <0.33.0> Application acceptor_pool started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.692 [info] <0.33.0> Application asn1 started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.693 [info] <0.33.0> Application public_key started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.739 [info] <0.33.0> Application ssl started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.742 [info] <0.33.0> Application rand_compat started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.747 [info] <0.33.0> Application quickrand started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.748 [info] <0.33.0> Application uuid started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.756 [info] <0.189.0>@partisan_config:init:58 Using node name: 'node_1@127.0.0.1'
2018-05-08 16:20:13.764 [info] <0.191.0>@partisan_config:get_node_address:168 Resolving "127.0.0.1"...
2018-05-08 16:20:13.764 [info] <0.191.0>@partisan_config:get_node_address:171 Resolved "node_1@127.0.0.1" to {127,0,0,1}
2018-05-08 16:20:13.764 [info] <0.189.0>@partisan_config:get_node_address:188 Resolved "127.0.0.1" to {127,0,0,1}
2018-05-08 16:20:13.975 [info] <0.33.0> Application partisan started on node 'node_1@127.0.0.1'
2018-05-08 16:20:13.985 [info] <0.33.0> Application gen_fsm_compat started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.011 [info] <0.33.0> Application riak_sysmon started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.049 [info] <0.33.0> Application os_mon started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.057 [info] <0.33.0> Application basho_stats started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.059 [info] <0.33.0> Application eleveldb started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.060 [info] <0.33.0> Application pbkdf2 started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.061 [info] <0.33.0> Application poolboy started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.096 [info] <0.268.0>@exometer_report:do_start_reporters:613 Starting reporters with []
2018-05-08 16:20:14.097 [info] <0.33.0> Application exometer_core started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.135 [info] <0.33.0> Application clique started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.149 [info] <0.33.0> Application folsom started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.185 [info] <0.286.0>@riak_core_partisan_utils:configure_dispatch:145 Configuring partisan dispatch: true
2018-05-08 16:20:14.243 [warning] <0.302.0>@riak_core_ring_manager:reload_ring:380 No ring file available.
2018-05-08 16:20:14.487 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,vnode_routing} = proxy
2018-05-08 16:20:14.491 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,staged_joins} = true
2018-05-08 16:20:14.496 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,resizable_ring} = true
2018-05-08 16:20:14.504 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,fold_req_version} = v2
2018-05-08 16:20:14.510 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,security} = true
2018-05-08 16:20:14.523 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,bucket_types} = true
2018-05-08 16:20:14.534 [info] <0.319.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,net_ticktime} = true
2018-05-08 16:20:14.694 [info] <0.33.0> Application riak_core started on node 'node_1@127.0.0.1'
2018-05-08 16:20:14.754 [info] <0.33.0> Application setup started on node 'node_1@127.0.0.1'
2018-05-08 16:20:23.517 [error] <0.222.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:20:26.853 [info] <0.302.0>@riak_core_gossip:log_node_added:360 'node_2@127.0.0.1' joined cluster with status 'valid'
2018-05-08 16:20:29.608 [error] <0.222.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:20:38.201 [info] <0.302.0>@riak_core_gossip:log_node_added:360 'node_3@127.0.0.1' joined cluster with status 'joining'
2018-05-08 16:20:39.432 [info] <0.302.0>@riak_core_gossip:log_node_changed:357 'node_3@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:21:07.170 [info] <0.247.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.302.0> [{name,riak_core_ring_manager},{initial_call,{riak_core_ring_manager,init,1}},{almost_current_function,{lists,member,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},[253601486687639997|205556090268379804]}},{'$initial_call',{riak_core_ring_manager,init,1}},{'$ancestors',[riak_core_sup,<0.285.0>]}]}] [{timeout,75},{in,{riak_core_ring,next_owner,1}},{out,{lists,'-filter/2-lc$^0/1-0-',2}}]
2018-05-08 16:22:14.048 [info] <0.87.0> alarm_handler: {set,{system_memory_high_watermark,[]}}
2018-05-08 16:22:14.769 [info] <0.247.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule #Port<0.1137> name tcp_inet [{links,[<0.96.0>]},{id,9096},{connected,<0.96.0>},{input,89590},{output,60},{os_pid,undefined},{queue_size,0}] [{timeout,100},{port_op,dist_cmd}]
2018-05-08 16:22:47.171 [info] <0.247.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.301.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.285.0>]}]}] [{timeout,74},{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:22:47.620 [info] <0.247.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.301.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.285.0>]}]}] [{timeout,115},{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:22:48.141 [info] <0.247.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.301.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.285.0>]}]}] [{timeout,80},{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:22:49.147 [info] <0.285.0>@riak_core_app:stop:47 Stopped  application riak_core.
2018-05-08 16:22:49.167 [info] <0.87.0> alarm_handler: {clear,system_memory_high_watermark}
2018-05-08 16:20:15.005 [info] <0.33.0> Application lager started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.010 [info] <0.33.0> Application types started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.012 [info] <0.33.0> Application acceptor_pool started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.027 [info] <0.33.0> Application asn1 started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.028 [info] <0.33.0> Application public_key started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.060 [info] <0.33.0> Application ssl started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.062 [info] <0.33.0> Application rand_compat started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.068 [info] <0.33.0> Application quickrand started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.068 [info] <0.33.0> Application uuid started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.077 [info] <0.190.0>@partisan_config:init:58 Using node name: 'node_2@127.0.0.1'
2018-05-08 16:20:15.086 [info] <0.192.0>@partisan_config:get_node_address:168 Resolving "127.0.0.1"...
2018-05-08 16:20:15.087 [info] <0.192.0>@partisan_config:get_node_address:171 Resolved "node_2@127.0.0.1" to {127,0,0,1}
2018-05-08 16:20:15.087 [info] <0.190.0>@partisan_config:get_node_address:188 Resolved "127.0.0.1" to {127,0,0,1}
2018-05-08 16:20:15.213 [info] <0.33.0> Application partisan started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.218 [info] <0.33.0> Application gen_fsm_compat started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.229 [info] <0.33.0> Application riak_sysmon started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.258 [info] <0.33.0> Application os_mon started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.264 [info] <0.33.0> Application basho_stats started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.266 [info] <0.33.0> Application eleveldb started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.267 [info] <0.33.0> Application pbkdf2 started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.270 [info] <0.33.0> Application poolboy started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.313 [info] <0.269.0>@exometer_report:do_start_reporters:613 Starting reporters with []
2018-05-08 16:20:15.313 [info] <0.33.0> Application exometer_core started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.351 [info] <0.33.0> Application clique started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.377 [info] <0.33.0> Application folsom started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.413 [info] <0.287.0>@riak_core_partisan_utils:configure_dispatch:145 Configuring partisan dispatch: true
2018-05-08 16:20:15.509 [warning] <0.303.0>@riak_core_ring_manager:reload_ring:380 No ring file available.
2018-05-08 16:20:15.780 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,vnode_routing} = proxy
2018-05-08 16:20:15.785 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,staged_joins} = true
2018-05-08 16:20:15.790 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,resizable_ring} = true
2018-05-08 16:20:15.796 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,fold_req_version} = v2
2018-05-08 16:20:15.802 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,security} = true
2018-05-08 16:20:15.812 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,bucket_types} = true
2018-05-08 16:20:15.817 [info] <0.320.0>@riak_core_capability:process_capability_changes:568 New capability: {riak_core,net_ticktime} = true
2018-05-08 16:20:15.940 [info] <0.33.0> Application riak_core started on node 'node_2@127.0.0.1'
2018-05-08 16:20:15.953 [info] <0.33.0> Application setup started on node 'node_2@127.0.0.1'
2018-05-08 16:20:22.434 [info] <0.1377.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:20:23.455 [info] <0.1377.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:20:23.457 [info] <0.1377.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:20:23.470 [info] <0.1377.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:20:26.889 [info] <0.303.0>@riak_core_gossip:log_node_changed:357 'node_2@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:20:39.280 [info] <0.303.0>@riak_core_gossip:log_node_added:360 'node_3@127.0.0.1' joined cluster with status 'joining'
2018-05-08 16:20:39.604 [info] <0.303.0>@riak_core_gossip:log_node_changed:357 'node_3@127.0.0.1' changed from 'joining' to 'valid'
2018-05-08 16:22:15.259 [info] <0.92.0> alarm_handler: {set,{system_memory_high_watermark,[]}}
2018-05-08 16:22:36.191 [info] <0.248.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule #Port<0.723> name tcp_inet [{links,[<0.82.0>]},{id,5784},{connected,<0.82.0>},{input,94617},{output,60},{os_pid,undefined},{queue_size,0}] [{timeout,62},{port_op,dist_cmd}]
2018-05-08 16:22:47.419 [info] <0.248.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.302.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.286.0>]}]}] [{timeout,101},{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:22:47.858 [info] <0.248.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.302.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.286.0>]}]}] [{timeout,60},{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:22:48.258 [info] <0.248.0>@riak_core_sysmon_handler:handle_event:92 monitor long_schedule <0.302.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.286.0>]}]}] [{timeout,59},{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:22:50.078 [warning] <0.4062.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 56134}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:51.093 [warning] <0.4069.0>@partisan_peer_service_client:init:72 unable to connect to #{channels => [broadcast,vnode,{monotonic,gossip}],listen_addrs => [#{ip => {127,0,0,1},port => 56134}],name => 'node_1@127.0.0.1',parallelism => 1} due to {error,econnrefused}
2018-05-08 16:22:51.171 [info] <0.286.0>@riak_core_app:stop:47 Stopped  application riak_core.
2018-05-08 16:22:51.186 [info] <0.92.0> alarm_handler: {clear,system_memory_high_watermark}

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:20:06.898 [info] Using "node_1@127.0.0.1" as name, since running >= 20.0
16:20:06.898 [info] Starting node: 'node_1@127.0.0.1'
16:20:06.898 [info] Application lager started on node 'runner@127.0.0.1'
16:20:08.034 [info] Node started: 'node_1@127.0.0.1'
16:20:08.034 [info] Using "node_2@127.0.0.1" as name, since running >= 20.0
16:20:08.034 [info] Starting node: 'node_2@127.0.0.1'
16:20:09.106 [info] Node started: 'node_2@127.0.0.1'
16:20:09.109 [info] Using "node_3@127.0.0.1" as name, since running >= 20.0
16:20:09.109 [info] Starting node: 'node_3@127.0.0.1'
16:20:11.259 [info] Node started: 'node_3@127.0.0.1'
16:20:23.483 [info] Issuing normal join from 'node_2@127.0.0.1' to 'node_1@127.0.0.1': ok
16:20:29.597 [info] Issuing normal join from 'node_3@127.0.0.1' to 'node_1@127.0.0.1': ok
16:20:29.597 [info] Waiting for nodes to be ready...
16:20:29.597 [info] Waiting for node 'node_1@127.0.0.1' to be ready...
16:20:29.601 [info] Waiting for node 'node_2@127.0.0.1' to be ready...
16:20:29.605 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:30.610 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:31.621 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:32.633 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:33.636 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:34.640 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:35.650 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:36.660 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:37.661 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:38.664 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:39.666 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:40.673 [info] Waiting for node 'node_3@127.0.0.1' to be ready...
16:20:40.678 [info] All nodes ready!
16:20:40.678 [info] Waiting for ownership agreement...
16:22:38.212 [info] Waiting for handoff...
16:22:38.212 [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:22:39.314 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:40.316 [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:22:40.340 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:41.344 [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:22:41.402 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:42.404 [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:22:42.445 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:43.446 [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:22:43.471 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:44.471 [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:22:44.496 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:45.497 [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:22:45.576 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:46.579 [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:22:46.604 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [false,false,false]
16:22:47.604 [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:22:47.694 [info] -> BadNodes: [], length(Changes): 3, length(Nodes): 3, Changes: [true,true,true]
16:22:47.694 [info] No pending changes remain!
16:22:47.694 [info] Waiting for ring convergence...
16:22:48.756 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]

----------------------------------------------------
2018-05-08 16:22:49.032
Stopping node: node_1

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

----------------------------------------------------
2018-05-08 16:22:51.073
Stopping node: node_2

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

----------------------------------------------------
2018-05-08 16:22:53.082
Stopping node: node_3

Warning: ct_logs not started
Stopping node: node_316:22:53.082 [info] Using "node_3@127.0.0.1" as name, since running >= 20.0
.16:22:55.090 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:22:55.115 [info] Using "node_1@127.0.0.1" as name, since running >= 20.0
16:22:55.115 [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:22:58.162 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:22:58.169 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:22:58.177 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:22:58.187 [info] initial_state: nodes [node_1,node_2,node_3] joined_nodes [node_1,node_2,node_3]
16:22:58.216 [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,[[]]}.