mesos-issues mailing list archives

Site index · List index
Message view « Date » · « Thread »
Top « Date » · « Thread »
From "Till Toenshoff (JIRA)" <j...@apache.org>
Subject [jira] [Comment Edited] (MESOS-4029) ContentType/SchedulerTest seems flaky.
Date Tue, 01 Dec 2015 00:46:10 GMT

    [ https://issues.apache.org/jira/browse/MESOS-4029?page=com.atlassian.jira.plugin.system.issuetabpanels:comment-tabpanel&focusedCommentId=15032815#comment-15032815
] 

Till Toenshoff edited comment on MESOS-4029 at 12/1/15 12:46 AM:
-----------------------------------------------------------------

{noformat}
[ RUN      ] ContentType/SchedulerTest.TaskRunning/0
*** Aborted at 1448930379 (unix time) try "date -d @1448930379" if you are using GNU date
***
I1201 00:39:39.100646 17042 leveldb.cpp:176] Opened db in 2.364817ms
PC: @          0x1451b8e testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
*** SIGSEGV (@0x100000030) received by PID 17042 (TID 0x7f0b0cc27700) from PID 48; stack trace:
***
I1201 00:39:39.101135 17042 leveldb.cpp:183] Compacted db in 408797ns
I1201 00:39:39.101176 17042 leveldb.cpp:198] Created db iterator in 16480ns
I1201 00:39:39.101187 17042 leveldb.cpp:204] Seeked to beginning of db in 1246ns
I1201 00:39:39.101194 17042 leveldb.cpp:273] Iterated through 0 keys in the db in 143ns
I1201 00:39:39.101230 17042 replica.cpp:780] Replica recovered with log positions 0 ->
0 with 1 holes and 0 unlearned
    @     0x7f0b158fc340 (unknown)
I1201 00:39:39.101763 17057 recover.cpp:449] Starting replica recovery
I1201 00:39:39.102267 17063 recover.cpp:475] Replica is in EMPTY status
I1201 00:39:39.102772 17063 master.cpp:367] Master 9f2eedb2-8e4b-465d-95c9-9989325a0267 (ubuntu14)
started on 127.0.1.1:44839
I1201 00:39:39.102807 17063 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs"
--allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5"
--authorizers="local" --credentials="/tmp/C9wpvk/credentials" --framework_sorter="drf" --help="false"
--hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0"
--logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%"
--registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs"
--registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins"
--user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/C9wpvk/master"
--zk_session_timeout="10secs"
I1201 00:39:39.103037 17063 master.cpp:416] Master allowing unauthenticated frameworks to
register
I1201 00:39:39.103060 17063 master.cpp:419] Master only allowing authenticated slaves to register
I1201 00:39:39.103071 17063 credentials.hpp:37] Loading credentials for authentication from
'/tmp/C9wpvk/credentials'
I1201 00:39:39.103323 17063 master.cpp:458] Using default 'crammd5' authenticator
I1201 00:39:39.103426 17063 master.cpp:495] Authorization enabled
I    @          0x1451b8e testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
1201 00:39:39.103624 17061 replica.cpp:676] Replica in EMPTY status received a broadcasted
recover request from (13624)@127.0.1.1:44839
I1201 00:39:39.105423 17061 master.cpp:1606] The newly elected leader is master@127.0.1.1:44839
with id 9f2eedb2-8e4b-465d-95c9-9989325a0267
I1201 00:39:39.105872 17061 master.cpp:1619] Elected as the leading master!
I1201 00:39:39.105892 17061 master.cpp:1379] Recovering from registrar
I1201 00:39:39.105700 17062 recover.cpp:195] Received a recover response from a replica in
EMPTY status
I1201 00:39:39.105999 17063 registrar.cpp:309] Recovering registrar
    @           0xe2ea6d _ZN7testing8internal18FunctionMockerBaseIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS6_SaIS6_EEEEE10InvokeWithERKSt5tupleIJSC_EE
I1201 00:39:39.106724 17062 recover.cpp:566] Updating replica status to STARTING
I1201 00:39:39.107606 17057 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
712403ns
I1201 00:39:39.107657 17057 replica.cpp:323] Persisted replica status to STARTING
I1201 00:39:39.107832 17057 recover.cpp:475] Replica is in STARTING status
I1201 00:39:39.108538 17062 replica.cpp:676] Replica in STARTING status received a broadcasted
recover request from (13625)@127.0.1.1:44839
I1201 00:39:39.108942 17062 recover.cpp:195] Received a recover response from a replica in
STARTING status
    @           0xe2b1bc testing::internal::FunctionMocker<>::Invoke()
I1201 00:39:39.109571 17062 recover.cpp:566] Updating replica status to VOTING
I1201 00:39:39.110317 17057 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
286144ns
I1201 00:39:39.110373 17057 replica.cpp:323] Persisted replica status to VOTING
I1201 00:39:39.110457 17057 recover.cpp:580] Successfully joined the Paxos group
I1201 00:39:39.110757 17057 recover.cpp:464] Recover process terminated
    @          0x1118aed mesos::internal::tests::SchedulerTest::Callbacks::received()
I1201 00:39:39.111263 17062 log.cpp:661] Attempting to start the writer
    @          0x111c453 _ZNKSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS0_2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEEclIJSE_EvEEvRS4_DpOT_
I1201 00:39:39.112156 17058 replica.cpp:496] Replica received implicit promise request from
(13626)@127.0.1.1:44839 with proposal 1
I1201 00:39:39.112442 17058 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
232139ns
I1201 00:39:39.112490 17058 replica.cpp:345] Persisted promised to 1
I    @          0x111c001 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS1_2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESt17reference_wrapperIS5_ESt12_PlaceholderILi1EEEE6__callIvJSF_EJLm0ELm1EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
1201 00:39:39.113093 17057 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1201 00:39:39.114286 17060 replica.cpp:391] Replica received explicit promise request from
(13627)@127.0.1.1:44839 for position 0 with proposal 2
    @          0x111b90d _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS1_2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESt17reference_wrapperIS5_ESt12_PlaceholderILi1EEEEclIJSF_EvEET0_DpOT_
I1201 00:39:39.114645 17060 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 301419ns
I1201 00:39:39.114687 17060 replica.cpp:715] Persisted action at 0
    @          0x111ae09 std::_Function_handler<>::_M_invoke()
I1201 00:39:39.115533 17058 replica.cpp:540] Replica received write request for position 0
from (13628)@127.0.1.1:44839
I1201 00:39:39.115600 17058 leveldb.cpp:438] Reading position from leveldb took 20141ns
I1201 00:39:39.115886 17058 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took
257171ns
I1201 00:39:39.115928 17058 replica.cpp:715] Persisted action at 0
    @     0x7f0b19e18979 std::function<>::operator()()
I1201 00:39:39.116281 17058 replica.cpp:694] Replica received learned notice for position
0 from @0.0.0.0:0
I1201 00:39:39.116608 17058 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
303631ns
I1201 00:39:39.116652 17058 replica.cpp:715] Persisted action at 0
I1201 00:39:39.116668 17058 replica.cpp:700] Replica learned NOP action at position 0
I1201 00:39:39.117130 17058 log.cpp:677] Writer started with ending position 0
I1201 00:39:39.118099 17058 leveldb.cpp:438] Reading position from leveldb took 22654ns
    @     0x7f0b19e1385e process::AsyncExecutorProcess::execute<>()
I1201 00:39:39.118892 17056 registrar.cpp:342] Successfully fetched the registry (0B) in 12.718848ms
I1201 00:39:39.119061 17056 registrar.cpp:441] Applied 1 operations in 34716ns; attempting
to update the 'registry'
I1201 00:39:39.119572 17062 log.cpp:685] Attempting to append 158 bytes to the log
I1201 00:39:39.119781 17061 coordinator.cpp:350] Coordinator attempting to write APPEND action
at position 1
I1201 00:39:39.120560 17061 replica.cpp:540] Replica received write request for position 1
from (13629)@127.0.1.1:44839
I1201 00:39:39.120977 17061 leveldb.cpp:343] Persisting action (177 bytes) to leveldb took
314676ns
I1201 00:39:39.121022 17061 replica.cpp:715] Persisted action at 1
    @     0x7f0b19e18a9a _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEESC_PvSG_SC_SJ_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_T3_ET4_T5_T6_ENKUlPNS_11ProcessBaseEE_clES11_
I1201 00:39:39.121557 17063 replica.cpp:694] Replica received learned notice for position
1 from @0.0.0.0:0
I1201 00:39:39.121863 17063 leveldb.cpp:343] Persisting action (179 bytes) to leveldb took
276125ns
I1201 00:39:39.121886 17063 replica.cpp:715] Persisted action at 1
I1201 00:39:39.121906 17063 replica.cpp:700] Replica learned APPEND action at position 1
I1201 00:39:39.122795 17057 registrar.cpp:486] Successfully updated the 'registry' in 3.64288ms
I1201 00:39:39.122915 17057 registrar.cpp:372] Successfully recovered registrar
I1201 00:39:39.122982 17060 log.cpp:704] Attempting to truncate the log to 1
I1201 00:39:39.123113 17060 coordinator.cpp:350] Coordinator attempting to write TRUNCATE
action at position 2
I1201 00:39:39.123134 17057 master.cpp:1416] Recovered 0 slaves from the Registry (120B) ;
allowing 10mins for slaves to re-register
I    @     0x7f0b19e21514 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeISC_SaISC_EEEEESG_PvSK_SG_SN_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSS_FSP_T1_T2_T3_ET4_T5_T6_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
1201 00:39:39.124070 17062 replica.cpp:540] Replica received write request for position 2
from (13630)@127.0.1.1:44839
I1201 00:39:39.124531 17062 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
348386ns
I1201 00:39:39.124588 17062 replica.cpp:715] Persisted action at 2
I1201 00:39:39.125355 17062 replica.cpp:694] Replica received learned notice for position
2 from @0.0.0.0:0
I1201 00:39:39.125849 17062 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took
314890ns
I1201 00:39:39.125913 17062 leveldb.cpp:401] Deleting ~1 keys from leveldb took 22454ns
I1201 00:39:39.125928 17062 replica.cpp:715] Persisted action at 2
I1201 00:39:39.125946 17062 replica.cpp:700] Replica learned TRUNCATE action at position 2
    @     0x7f0b1a85c16f std::function<>::operator()()
    @     0x7f0b1a84457d process::ProcessBase::visit()
    @     0x7f0b1a8483ee process::DispatchEvent::visit()
    @           0x9dc0ba process::ProcessBase::serve()
    @     0x7f0b1a84083a process::ProcessManager::resume()
    @     0x7f0b1a83da0a _ZZN7process14ProcessManager12init_threadsEvENKUlRKSt11atomic_boolE_clES3_
    @     0x7f0b1a847c1a _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEE6__callIvIEILm0EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
    @     0x7f0b1a847bca _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEEclIIEvEET0_DpOT_
    @     0x7f0b1a847b5c _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x7f0b1a847ab3 _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEEclEv
    @     0x7f0b1a847a4c _ZNSt6thread5_ImplISt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS6_EEEvEEE6_M_runEv
    @     0x7f0b160d7a40 (unknown)
    @     0x7f0b158f4182 start_thread
    @     0x7f0b1562147d (unknown)
{noformat}

The above happened in tight loop run of the suite on Ubuntu 14:
{noformat}
sudo ./bin/mesos-tests.sh --gtest_repeat=-1 --gtest_break_on_failure --gtest_filter="ContentType/SchedulerTest*"
—verbose)
{noformat}


was (Author: tillt):
{noformat}
[ RUN      ] ContentType/SchedulerTest.TaskRunning/0
*** Aborted at 1448930379 (unix time) try "date -d @1448930379" if you are using GNU date
***
I1201 00:39:39.100646 17042 leveldb.cpp:176] Opened db in 2.364817ms
PC: @          0x1451b8e testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
*** SIGSEGV (@0x100000030) received by PID 17042 (TID 0x7f0b0cc27700) from PID 48; stack trace:
***
I1201 00:39:39.101135 17042 leveldb.cpp:183] Compacted db in 408797ns
I1201 00:39:39.101176 17042 leveldb.cpp:198] Created db iterator in 16480ns
I1201 00:39:39.101187 17042 leveldb.cpp:204] Seeked to beginning of db in 1246ns
I1201 00:39:39.101194 17042 leveldb.cpp:273] Iterated through 0 keys in the db in 143ns
I1201 00:39:39.101230 17042 replica.cpp:780] Replica recovered with log positions 0 ->
0 with 1 holes and 0 unlearned
    @     0x7f0b158fc340 (unknown)
I1201 00:39:39.101763 17057 recover.cpp:449] Starting replica recovery
I1201 00:39:39.102267 17063 recover.cpp:475] Replica is in EMPTY status
I1201 00:39:39.102772 17063 master.cpp:367] Master 9f2eedb2-8e4b-465d-95c9-9989325a0267 (ubuntu14)
started on 127.0.1.1:44839
I1201 00:39:39.102807 17063 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs"
--allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5"
--authorizers="local" --credentials="/tmp/C9wpvk/credentials" --framework_sorter="drf" --help="false"
--hostname_lookup="true" --initialize_driver_logging="true" --log_auto_initialize="true" --logbufsecs="0"
--logging_level="INFO" --max_slave_ping_timeouts="5" --quiet="false" --recovery_slave_removal_limit="100%"
--registry="replicated_log" --registry_fetch_timeout="1mins" --registry_store_timeout="25secs"
--registry_strict="true" --root_submissions="true" --slave_ping_timeout="15secs" --slave_reregister_timeout="10mins"
--user_sorter="drf" --version="false" --webui_dir="/usr/local/share/mesos/webui" --work_dir="/tmp/C9wpvk/master"
--zk_session_timeout="10secs"
I1201 00:39:39.103037 17063 master.cpp:416] Master allowing unauthenticated frameworks to
register
I1201 00:39:39.103060 17063 master.cpp:419] Master only allowing authenticated slaves to register
I1201 00:39:39.103071 17063 credentials.hpp:37] Loading credentials for authentication from
'/tmp/C9wpvk/credentials'
I1201 00:39:39.103323 17063 master.cpp:458] Using default 'crammd5' authenticator
I1201 00:39:39.103426 17063 master.cpp:495] Authorization enabled
I    @          0x1451b8e testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
1201 00:39:39.103624 17061 replica.cpp:676] Replica in EMPTY status received a broadcasted
recover request from (13624)@127.0.1.1:44839
I1201 00:39:39.105423 17061 master.cpp:1606] The newly elected leader is master@127.0.1.1:44839
with id 9f2eedb2-8e4b-465d-95c9-9989325a0267
I1201 00:39:39.105872 17061 master.cpp:1619] Elected as the leading master!
I1201 00:39:39.105892 17061 master.cpp:1379] Recovering from registrar
I1201 00:39:39.105700 17062 recover.cpp:195] Received a recover response from a replica in
EMPTY status
I1201 00:39:39.105999 17063 registrar.cpp:309] Recovering registrar
    @           0xe2ea6d _ZN7testing8internal18FunctionMockerBaseIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS6_SaIS6_EEEEE10InvokeWithERKSt5tupleIJSC_EE
I1201 00:39:39.106724 17062 recover.cpp:566] Updating replica status to STARTING
I1201 00:39:39.107606 17057 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
712403ns
I1201 00:39:39.107657 17057 replica.cpp:323] Persisted replica status to STARTING
I1201 00:39:39.107832 17057 recover.cpp:475] Replica is in STARTING status
I1201 00:39:39.108538 17062 replica.cpp:676] Replica in STARTING status received a broadcasted
recover request from (13625)@127.0.1.1:44839
I1201 00:39:39.108942 17062 recover.cpp:195] Received a recover response from a replica in
STARTING status
    @           0xe2b1bc testing::internal::FunctionMocker<>::Invoke()
I1201 00:39:39.109571 17062 recover.cpp:566] Updating replica status to VOTING
I1201 00:39:39.110317 17057 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
286144ns
I1201 00:39:39.110373 17057 replica.cpp:323] Persisted replica status to VOTING
I1201 00:39:39.110457 17057 recover.cpp:580] Successfully joined the Paxos group
I1201 00:39:39.110757 17057 recover.cpp:464] Recover process terminated
    @          0x1118aed mesos::internal::tests::SchedulerTest::Callbacks::received()
I1201 00:39:39.111263 17062 log.cpp:661] Attempting to start the writer
    @          0x111c453 _ZNKSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS0_2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEEclIJSE_EvEEvRS4_DpOT_
I1201 00:39:39.112156 17058 replica.cpp:496] Replica received implicit promise request from
(13626)@127.0.1.1:44839 with proposal 1
I1201 00:39:39.112442 17058 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took
232139ns
I1201 00:39:39.112490 17058 replica.cpp:345] Persisted promised to 1
I    @          0x111c001 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS1_2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESt17reference_wrapperIS5_ESt12_PlaceholderILi1EEEE6__callIvJSF_EJLm0ELm1EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
1201 00:39:39.113093 17057 coordinator.cpp:240] Coordinator attempting to fill missing positions
I1201 00:39:39.114286 17060 replica.cpp:391] Replica received explicit promise request from
(13627)@127.0.1.1:44839 for position 0 with proposal 2
    @          0x111b90d _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS1_2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESt17reference_wrapperIS5_ESt12_PlaceholderILi1EEEEclIJSF_EvEET0_DpOT_
I1201 00:39:39.114645 17060 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 301419ns
I1201 00:39:39.114687 17060 replica.cpp:715] Persisted action at 0
    @          0x111ae09 std::_Function_handler<>::_M_invoke()
I1201 00:39:39.115533 17058 replica.cpp:540] Replica received write request for position 0
from (13628)@127.0.1.1:44839
I1201 00:39:39.115600 17058 leveldb.cpp:438] Reading position from leveldb took 20141ns
I1201 00:39:39.115886 17058 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took
257171ns
I1201 00:39:39.115928 17058 replica.cpp:715] Persisted action at 0
    @     0x7f0b19e18979 std::function<>::operator()()
I1201 00:39:39.116281 17058 replica.cpp:694] Replica received learned notice for position
0 from @0.0.0.0:0
I1201 00:39:39.116608 17058 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
303631ns
I1201 00:39:39.116652 17058 replica.cpp:715] Persisted action at 0
I1201 00:39:39.116668 17058 replica.cpp:700] Replica learned NOP action at position 0
I1201 00:39:39.117130 17058 log.cpp:677] Writer started with ending position 0
I1201 00:39:39.118099 17058 leveldb.cpp:438] Reading position from leveldb took 22654ns
    @     0x7f0b19e1385e process::AsyncExecutorProcess::execute<>()
I1201 00:39:39.118892 17056 registrar.cpp:342] Successfully fetched the registry (0B) in 12.718848ms
I1201 00:39:39.119061 17056 registrar.cpp:441] Applied 1 operations in 34716ns; attempting
to update the 'registry'
I1201 00:39:39.119572 17062 log.cpp:685] Attempting to append 158 bytes to the log
I1201 00:39:39.119781 17061 coordinator.cpp:350] Coordinator attempting to write APPEND action
at position 1
I1201 00:39:39.120560 17061 replica.cpp:540] Replica received write request for position 1
from (13629)@127.0.1.1:44839
I1201 00:39:39.120977 17061 leveldb.cpp:343] Persisting action (177 bytes) to leveldb took
314676ns
I1201 00:39:39.121022 17061 replica.cpp:715] Persisted action at 1
    @     0x7f0b19e18a9a _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEESC_PvSG_SC_SJ_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_T3_ET4_T5_T6_ENKUlPNS_11ProcessBaseEE_clES11_
I1201 00:39:39.121557 17063 replica.cpp:694] Replica received learned notice for position
1 from @0.0.0.0:0
I1201 00:39:39.121863 17063 leveldb.cpp:343] Persisting action (179 bytes) to leveldb took
276125ns
I1201 00:39:39.121886 17063 replica.cpp:715] Persisted action at 1
I1201 00:39:39.121906 17063 replica.cpp:700] Replica learned APPEND action at position 1
I1201 00:39:39.122795 17057 registrar.cpp:486] Successfully updated the 'registry' in 3.64288ms
I1201 00:39:39.122915 17057 registrar.cpp:372] Successfully recovered registrar
I1201 00:39:39.122982 17060 log.cpp:704] Attempting to truncate the log to 1
I1201 00:39:39.123113 17060 coordinator.cpp:350] Coordinator attempting to write TRUNCATE
action at position 2
I1201 00:39:39.123134 17057 master.cpp:1416] Recovered 0 slaves from the Registry (120B) ;
allowing 10mins for slaves to re-register
I    @     0x7f0b19e21514 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeISC_SaISC_EEEEESG_PvSK_SG_SN_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSS_FSP_T1_T2_T3_ET4_T5_T6_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
1201 00:39:39.124070 17062 replica.cpp:540] Replica received write request for position 2
from (13630)@127.0.1.1:44839
I1201 00:39:39.124531 17062 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took
348386ns
I1201 00:39:39.124588 17062 replica.cpp:715] Persisted action at 2
I1201 00:39:39.125355 17062 replica.cpp:694] Replica received learned notice for position
2 from @0.0.0.0:0
I1201 00:39:39.125849 17062 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took
314890ns
I1201 00:39:39.125913 17062 leveldb.cpp:401] Deleting ~1 keys from leveldb took 22454ns
I1201 00:39:39.125928 17062 replica.cpp:715] Persisted action at 2
I1201 00:39:39.125946 17062 replica.cpp:700] Replica learned TRUNCATE action at position 2
    @     0x7f0b1a85c16f std::function<>::operator()()
    @     0x7f0b1a84457d process::ProcessBase::visit()
    @     0x7f0b1a8483ee process::DispatchEvent::visit()
    @           0x9dc0ba process::ProcessBase::serve()
    @     0x7f0b1a84083a process::ProcessManager::resume()
    @     0x7f0b1a83da0a _ZZN7process14ProcessManager12init_threadsEvENKUlRKSt11atomic_boolE_clES3_
    @     0x7f0b1a847c1a _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEE6__callIvIEILm0EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
    @     0x7f0b1a847bca _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEEclIIEvEET0_DpOT_
    @     0x7f0b1a847b5c _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
    @     0x7f0b1a847ab3 _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEEclEv
    @     0x7f0b1a847a4c _ZNSt6thread5_ImplISt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS6_EEEvEEE6_M_runEv
    @     0x7f0b160d7a40 (unknown)
    @     0x7f0b158f4182 start_thread
    @     0x7f0b1562147d (unknown)
{noformat}

> ContentType/SchedulerTest seems flaky.
> --------------------------------------
>
>                 Key: MESOS-4029
>                 URL: https://issues.apache.org/jira/browse/MESOS-4029
>             Project: Mesos
>          Issue Type: Bug
>    Affects Versions: 0.26.0
>            Reporter: Till Toenshoff
>              Labels: flaky, flaky-test
>
> SSL build, [Ubuntu 14.04|https://github.com/tillt/mesos-vagrant-ci/blob/master/ubuntu14/setup.sh],
non-root test run.
> {noformat}
> [----------] 22 tests from ContentType/SchedulerTest
> [ RUN      ] ContentType/SchedulerTest.Subscribe/0
> [       OK ] ContentType/SchedulerTest.Subscribe/0 (48 ms)
> *** Aborted at 1448928007 (unix time) try "date -d @1448928007" if you are using GNU
date ***
> [ RUN      ] ContentType/SchedulerTest.Subscribe/1
> PC: @          0x1451b8e testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
> *** SIGSEGV (@0x100000030) received by PID 21320 (TID 0x2b549e5d4700) from PID 48; stack
trace: ***
>     @     0x2b54c95940b7 os::Linux::chained_handler()
>     @     0x2b54c9598219 JVM_handle_linux_signal
>     @     0x2b5496300340 (unknown)
>     @          0x1451b8e testing::internal::UntypedFunctionMockerBase::UntypedInvokeWith()
>     @           0xe2ea6d _ZN7testing8internal18FunctionMockerBaseIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS6_SaIS6_EEEEE10InvokeWithERKSt5tupleIJSC_EE
>     @           0xe2b1bc testing::internal::FunctionMocker<>::Invoke()
>     @          0x1118aed mesos::internal::tests::SchedulerTest::Callbacks::received()
>     @          0x111c453 _ZNKSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS0_2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEEclIJSE_EvEEvRS4_DpOT_
>     @          0x111c001 _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS1_2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESt17reference_wrapperIS5_ESt12_PlaceholderILi1EEEE6__callIvJSF_EJLm0ELm1EEEET_OSt5tupleIJDpT0_EESt12_Index_tupleIJXspT1_EEE
>     @          0x111b90d _ZNSt5_BindIFSt7_Mem_fnIMN5mesos8internal5tests13SchedulerTest9CallbacksEFvRKSt5queueINS1_2v19scheduler5EventESt5dequeIS9_SaIS9_EEEEESt17reference_wrapperIS5_ESt12_PlaceholderILi1EEEEclIJSF_EvEET0_DpOT_
>     @          0x111ae09 std::_Function_handler<>::_M_invoke()
>     @     0x2b5493c6da09 std::function<>::operator()()
>     @     0x2b5493c688ee process::AsyncExecutorProcess::execute<>()
>     @     0x2b5493c6db2a _ZZN7process8dispatchI7NothingNS_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeIS8_SaIS8_EEEEESC_PvSG_SC_SJ_EENS_6FutureIT_EERKNS_3PIDIT0_EEMSO_FSL_T1_T2_T3_ET4_T5_T6_ENKUlPNS_11ProcessBaseEE_clES11_
>     @     0x2b5493c765a4 _ZNSt17_Function_handlerIFvPN7process11ProcessBaseEEZNS0_8dispatchI7NothingNS0_20AsyncExecutorProcessERKSt8functionIFvRKSt5queueIN5mesos2v19scheduler5EventESt5dequeISC_SaISC_EEEEESG_PvSK_SG_SN_EENS0_6FutureIT_EERKNS0_3PIDIT0_EEMSS_FSP_T1_T2_T3_ET4_T5_T6_EUlS2_E_E9_M_invokeERKSt9_Any_dataS2_
>     @     0x2b54946b1201 std::function<>::operator()()
>     @     0x2b549469960f process::ProcessBase::visit()
>     @     0x2b549469d480 process::DispatchEvent::visit()
>     @           0x9dc0ba process::ProcessBase::serve()
>     @     0x2b54946958cc process::ProcessManager::resume()
>     @     0x2b5494692a9c _ZZN7process14ProcessManager12init_threadsEvENKUlRKSt11atomic_boolE_clES3_
>     @     0x2b549469ccac _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEE6__callIvIEILm0EEEET_OSt5tupleIIDpT0_EESt12_Index_tupleIIXspT1_EEE
>     @     0x2b549469cc5c _ZNSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS3_EEEclIIEvEET0_DpOT_
>     @     0x2b549469cbee _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEE9_M_invokeIIEEEvSt12_Index_tupleIIXspT_EEE
>     @     0x2b549469cb45 _ZNSt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS4_EEEvEEclEv
>     @     0x2b549469cade _ZNSt6thread5_ImplISt12_Bind_simpleIFSt5_BindIFZN7process14ProcessManager12init_threadsEvEUlRKSt11atomic_boolE_St17reference_wrapperIS6_EEEvEEE6_M_runEv
>     @     0x2b5495b81a40 (unknown)
>     @     0x2b54962f8182 start_thread
>     @     0x2b549660847d (unknown)
> make[3]: *** [check-local] Segmentation fault
> make[3]: Leaving directory `/home/vagrant/mesos/build/src'
> make[2]: *** [check-am] Error 2
> make[2]: Leaving directory `/home/vagrant/mesos/build/src'
> make[1]: *** [check] Error 2
> make[1]: Leaving directory `/home/vagrant/mesos/build/src'
> make: *** [check-recursive] Error 1
> {noformat}



--
This message was sent by Atlassian JIRA
(v6.3.4#6332)

Mime
View raw message