Return-Path: X-Original-To: apmail-mesos-builds-archive@minotaur.apache.org Delivered-To: apmail-mesos-builds-archive@minotaur.apache.org Received: from mail.apache.org (hermes.apache.org [140.211.11.3]) by minotaur.apache.org (Postfix) with SMTP id 7FC2418818 for ; Sun, 8 Nov 2015 06:40:28 +0000 (UTC) Received: (qmail 71437 invoked by uid 500); 8 Nov 2015 06:40:28 -0000 Delivered-To: apmail-mesos-builds-archive@mesos.apache.org Received: (qmail 71412 invoked by uid 500); 8 Nov 2015 06:40:28 -0000 Mailing-List: contact builds-help@mesos.apache.org; run by ezmlm Precedence: bulk List-Help: List-Unsubscribe: List-Post: List-Id: Reply-To: builds@mesos.apache.org Delivered-To: mailing list builds@mesos.apache.org Received: (qmail 71396 invoked by uid 99); 8 Nov 2015 06:40:28 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Sun, 08 Nov 2015 06:40:28 +0000 Received: from crius.apache.org (localhost [127.0.0.1]) by crius.apache.org (ASF Mail Server at crius.apache.org) with ESMTP id 04E319C06F4; Sun, 8 Nov 2015 06:40:15 +0000 (UTC) Date: Sun, 8 Nov 2015 06:40:14 +0000 (UTC) From: Apache Jenkins Server To: builds@mesos.apache.org, mpark@apache.org Message-ID: <2004979997.10342.1446964815016.JavaMail.jenkins@crius> Subject: =?UTF-8?Q?Build_failed_in_Jenkins:_Mesos_=C2=BB_clang,--?= =?UTF-8?Q?verbose,ubuntu:14.04,docker||Hadoop_#1194?= MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: 7bit X-Instance-Identity: MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAkqVKZPv7YyHBB3FvWfV7XQehwe/Ga3aadzSNknt8g382X3uN8A3SOQ+Ixq9HxS+ZlN6XR4TECySmSRy2JN5Rx8svxAD0TjtSF9LuU98dD+LniNDP7Lq6gvRFuJhbMHoS0nuTizDZLsK4X8TW5MyV9w+jFbdoZfRE5O/Mse0fkOeL5uoIS/3Vvu/W+x9QSjDkB7CaU56bPFlQjqqJBl3Cn9r34CkXQZYnLb/NjW4vcpw0+TgMUAPTIVEr5BTPZRshz19g7huwg3zANT5HBIZnzV4hsVY9w4JHkceFdKi/ibNnjPjsFs9pm0HSGJ/RDxjIvSTYT02eH4+m1RAYaj2E9QIDAQAB X-Jenkins-Job: Mesos/COMPILER=clang,CONFIGURATION=--verbose,OS=ubuntu:14.04,label_exp=docker||Hadoop X-Jenkins-Result: FAILURE See Changes: [mpark] stout: Added `JSON::protobuf` for `google::protobuf::RepeatedPtrField`. [mpark] mesos: Added `JSON::protobuf` for `google::protobuf::RepeatedPtrField`. ------------------------------------------ [...truncated 138551 lines...] I1108 06:40:21.847628 28042 slave.cpp:2034] Shutting down framework 15ad83bb-38c8-4039-9680-ee41a91102bc-0000 I1108 06:40:21.847693 28042 slave.cpp:3657] Cleaning up executor 'default' of framework 15ad83bb-38c8-4039-9680-ee41a91102bc-0000 at executor(132)@172.17.5.214:46896 I1108 06:40:21.848004 28039 gc.cpp:56] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_DPL3bD/slaves/15ad83bb-38c8-4039-9680-ee41a91102bc-S0/frameworks/15ad83bb-38c8-4039-9680-ee41a91102bc-0000/executors/default/runs/e26d621c-be2b-44aa-b0c9-c504dd64e0b9' for gc 6.99999018710519days in the future I1108 06:40:21.848307 28042 slave.cpp:3745] Cleaning up framework 15ad83bb-38c8-4039-9680-ee41a91102bc-0000 I1108 06:40:21.848533 28042 gc.cpp:56] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_DPL3bD/slaves/15ad83bb-38c8-4039-9680-ee41a91102bc-S0/frameworks/15ad83bb-38c8-4039-9680-ee41a91102bc-0000/executors/default' for gc 6.99999018234963days in the future I1108 06:40:21.848634 28042 gc.cpp:56] Scheduling '/tmp/ContentType_SchedulerTest_Message_1_DPL3bD/slaves/15ad83bb-38c8-4039-9680-ee41a91102bc-S0/frameworks/15ad83bb-38c8-4039-9680-ee41a91102bc-0000' for gc 6.99999018038222days in the future I1108 06:40:21.848733 28042 status_update_manager.cpp:284] Closing status update streams for framework 15ad83bb-38c8-4039-9680-ee41a91102bc-0000 I1108 06:40:21.848791 28042 status_update_manager.cpp:530] Cleaning up status update stream for task 7bbcacfb-ed3b-4915-bd48-9c3e4ec8c482 of framework 15ad83bb-38c8-4039-9680-ee41a91102bc-0000 [ OK ] ContentType/SchedulerTest.Message/1 (145 ms) [ RUN ] ContentType/SchedulerTest.Request/0 I1108 06:40:21.856161 28010 leveldb.cpp:176] Opened db in 2.486118ms I1108 06:40:21.858994 28010 leveldb.cpp:183] Compacted db in 2.801556ms I1108 06:40:21.859048 28010 leveldb.cpp:198] Created db iterator in 28376ns I1108 06:40:21.859064 28010 leveldb.cpp:204] Seeked to beginning of db in 7790ns I1108 06:40:21.859074 28010 leveldb.cpp:273] Iterated through 0 keys in the db in 5626ns I1108 06:40:21.859117 28010 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I1108 06:40:21.860136 28038 recover.cpp:449] Starting replica recovery I1108 06:40:21.860460 28029 recover.cpp:475] Replica is in EMPTY status I1108 06:40:21.863699 28031 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10510)@172.17.5.214:46896 I1108 06:40:21.864294 28031 recover.cpp:195] Received a recover response from a replica in EMPTY status I1108 06:40:21.865228 28041 recover.cpp:566] Updating replica status to STARTING I1108 06:40:21.865524 28032 master.cpp:367] Master 06998f21-3efb-4ae6-b764-64001e91febf (f5b7a4eba46a) started on 172.17.5.214:46896 I1108 06:40:21.865564 28032 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/1TBi1G/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="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/1TBi1G/master" --zk_session_timeout="10secs" I1108 06:40:21.865891 28032 master.cpp:416] Master allowing unauthenticated frameworks to register I1108 06:40:21.865906 28032 master.cpp:419] Master only allowing authenticated slaves to register I1108 06:40:21.865914 28032 credentials.hpp:37] Loading credentials for authentication from '/tmp/1TBi1G/credentials' I1108 06:40:21.866238 28032 master.cpp:458] Using default 'crammd5' authenticator I1108 06:40:21.866379 28032 master.cpp:495] Authorization enabled I1108 06:40:21.866631 28043 whitelist_watcher.cpp:79] No whitelist given I1108 06:40:21.866735 28033 hierarchical.cpp:140] Initialized hierarchical allocator process I1108 06:40:21.866943 28041 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 1.012744ms I1108 06:40:21.866984 28041 replica.cpp:323] Persisted replica status to STARTING I1108 06:40:21.867208 28041 recover.cpp:475] Replica is in STARTING status I1108 06:40:21.869205 28029 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10511)@172.17.5.214:46896 I1108 06:40:21.871006 28032 master.cpp:1606] The newly elected leader is master@172.17.5.214:46896 with id 06998f21-3efb-4ae6-b764-64001e91febf I1108 06:40:21.871039 28032 master.cpp:1619] Elected as the leading master! I1108 06:40:21.871052 28032 master.cpp:1379] Recovering from registrar I1108 06:40:21.871203 28041 recover.cpp:195] Received a recover response from a replica in STARTING status I1108 06:40:21.871284 28032 registrar.cpp:309] Recovering registrar I1108 06:40:21.872126 28041 recover.cpp:566] Updating replica status to VOTING I1108 06:40:21.872967 28032 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 684827ns I1108 06:40:21.872998 28032 replica.cpp:323] Persisted replica status to VOTING I1108 06:40:21.873136 28041 recover.cpp:580] Successfully joined the Paxos group I1108 06:40:21.873333 28041 recover.cpp:464] Recover process terminated I1108 06:40:21.873893 28041 log.cpp:661] Attempting to start the writer I1108 06:40:21.875197 28043 replica.cpp:496] Replica received implicit promise request from (10512)@172.17.5.214:46896 with proposal 1 I1108 06:40:21.875731 28043 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 499106ns I1108 06:40:21.875761 28043 replica.cpp:345] Persisted promised to 1 I1108 06:40:21.876417 28036 coordinator.cpp:240] Coordinator attempting to fill missing positions I1108 06:40:21.878024 28030 replica.cpp:391] Replica received explicit promise request from (10513)@172.17.5.214:46896 for position 0 with proposal 2 I1108 06:40:21.878571 28030 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 506554ns I1108 06:40:21.878600 28030 replica.cpp:715] Persisted action at 0 I1108 06:40:21.879719 28030 replica.cpp:540] Replica received write request for position 0 from (10514)@172.17.5.214:46896 I1108 06:40:21.879791 28030 leveldb.cpp:438] Reading position from leveldb took 48059ns I1108 06:40:21.880324 28030 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 496032ns I1108 06:40:21.880352 28030 replica.cpp:715] Persisted action at 0 I1108 06:40:21.881002 28029 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0 I1108 06:40:21.881790 28029 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 769446ns I1108 06:40:21.881819 28029 replica.cpp:715] Persisted action at 0 I1108 06:40:21.881839 28029 replica.cpp:700] Replica learned NOP action at position 0 I1108 06:40:21.890200 28032 log.cpp:677] Writer started with ending position 0 I1108 06:40:21.891754 28029 leveldb.cpp:438] Reading position from leveldb took 95512ns I1108 06:40:21.893323 28041 registrar.cpp:342] Successfully fetched the registry (0B) in 21.988864ms I1108 06:40:21.893499 28041 registrar.cpp:441] Applied 1 operations in 53374ns; attempting to update the 'registry' I1108 06:40:21.894265 28032 log.cpp:685] Attempting to append 176 bytes to the log I1108 06:40:21.894374 28040 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1 I1108 06:40:21.895603 28036 replica.cpp:540] Replica received write request for position 1 from (10515)@172.17.5.214:46896 I1108 06:40:21.896342 28036 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 692913ns I1108 06:40:21.896373 28036 replica.cpp:715] Persisted action at 1 I1108 06:40:21.897110 28042 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0 I1108 06:40:21.897975 28042 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 840093ns I1108 06:40:21.898008 28042 replica.cpp:715] Persisted action at 1 I1108 06:40:21.898033 28042 replica.cpp:700] Replica learned APPEND action at position 1 I1108 06:40:21.899478 28038 registrar.cpp:486] Successfully updated the 'registry' in 5888us I1108 06:40:21.899687 28033 log.cpp:704] Attempting to truncate the log to 1 I1108 06:40:21.899921 28039 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2 I1108 06:40:21.900413 28038 registrar.cpp:372] Successfully recovered registrar I1108 06:40:21.901372 28039 master.cpp:1416] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register I1108 06:40:21.902125 28035 replica.cpp:540] Replica received write request for position 2 from (10516)@172.17.5.214:46896 I1108 06:40:21.902631 28035 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 464727ns I1108 06:40:21.902662 28035 replica.cpp:715] Persisted action at 2 I1108 06:40:21.903383 28034 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0 I1108 06:40:21.903962 28034 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 556420ns I1108 06:40:21.904017 28034 leveldb.cpp:401] Deleting ~1 keys from leveldb took 39310ns I1108 06:40:21.904042 28034 replica.cpp:715] Persisted action at 2 I1108 06:40:21.904063 28034 replica.cpp:700] Replica learned TRUNCATE action at position 2 I1108 06:40:21.912616 28010 scheduler.cpp:156] Version: 0.26.0 I1108 06:40:21.913538 28035 scheduler.cpp:238] New master detected at master@172.17.5.214:46896 I1108 06:40:21.915107 28035 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.5.214:46896 I1108 06:40:21.919033 28034 process.cpp:3075] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1108 06:40:21.919384 28034 http.cpp:334] HTTP POST for /master/api/v1/scheduler from 172.17.5.214:54986 I1108 06:40:21.919692 28034 master.cpp:1868] Received subscription request for HTTP framework 'default' I1108 06:40:21.919724 28034 master.cpp:1645] Authorizing framework principal 'test-principal' to receive offers for role '*' I1108 06:40:21.920506 28034 master.cpp:1960] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I1108 06:40:21.921113 28034 hierarchical.cpp:185] Added framework 06998f21-3efb-4ae6-b764-64001e91febf-0000 I1108 06:40:21.921138 28030 master.hpp:1439] Sending heartbeat to 06998f21-3efb-4ae6-b764-64001e91febf-0000 I1108 06:40:21.921182 28034 hierarchical.cpp:952] No resources available to allocate! I1108 06:40:21.921226 28034 hierarchical.cpp:1045] No inverse offers to send out! I1108 06:40:21.921252 28034 hierarchical.cpp:851] Performed allocation for 0 slaves in 122516ns I1108 06:40:21.923188 28042 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.5.214:46896 I1108 06:40:21.924028 28034 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.5.214:46896 I1108 06:40:21.925034 28043 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event I1108 06:40:21.926375 28029 scheduler.cpp:300] Sending REQUEST call to master@172.17.5.214:46896 I1108 06:40:21.929585 28042 process.cpp:3075] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1108 06:40:21.929849 28042 http.cpp:334] HTTP POST for /master/api/v1/scheduler from 172.17.5.214:54987 I1108 06:40:21.930289 28042 master.cpp:2615] Processing REQUEST call for framework 06998f21-3efb-4ae6-b764-64001e91febf-0000 (default) I1108 06:40:21.930471 28037 hierarchical.cpp:449] Received resource request from framework 06998f21-3efb-4ae6-b764-64001e91febf-0000 I1108 06:40:21.930773 28037 master.cpp:922] Master terminating I1108 06:40:21.930995 28039 hierarchical.cpp:220] Removed framework 06998f21-3efb-4ae6-b764-64001e91febf-0000 E1108 06:40:21.935358 28030 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream [ OK ] ContentType/SchedulerTest.Request/0 (90 ms) [ RUN ] ContentType/SchedulerTest.Request/1 I1108 06:40:21.950306 28010 leveldb.cpp:176] Opened db in 6.698645ms I1108 06:40:21.954967 28010 leveldb.cpp:183] Compacted db in 4.623416ms I1108 06:40:21.955062 28010 leveldb.cpp:198] Created db iterator in 36523ns I1108 06:40:21.955082 28010 leveldb.cpp:204] Seeked to beginning of db in 9497ns I1108 06:40:21.955095 28010 leveldb.cpp:273] Iterated through 0 keys in the db in 6758ns I1108 06:40:21.955145 28010 replica.cpp:780] Replica recovered with log positions 0 -> 0 with 1 holes and 0 unlearned I1108 06:40:21.956745 28033 recover.cpp:449] Starting replica recovery I1108 06:40:21.958281 28036 master.cpp:367] Master 3e817a91-5c22-4c3c-ab09-684edc18fad3 (f5b7a4eba46a) started on 172.17.5.214:46896 I1108 06:40:21.958329 28036 master.cpp:369] Flags at startup: --acls="" --allocation_interval="1secs" --allocator="HierarchicalDRF" --authenticate="false" --authenticate_slaves="true" --authenticators="crammd5" --authorizers="local" --credentials="/tmp/KLThj3/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="/mesos/mesos-0.26.0/_inst/share/mesos/webui" --work_dir="/tmp/KLThj3/master" --zk_session_timeout="10secs" I1108 06:40:21.958654 28036 master.cpp:416] Master allowing unauthenticated frameworks to register I1108 06:40:21.958670 28036 master.cpp:419] Master only allowing authenticated slaves to register I1108 06:40:21.958679 28036 credentials.hpp:37] Loading credentials for authentication from '/tmp/KLThj3/credentials' I1108 06:40:21.958969 28036 master.cpp:458] Using default 'crammd5' authenticator I1108 06:40:21.959107 28036 master.cpp:495] Authorization enabled I1108 06:40:21.959251 28031 recover.cpp:475] Replica is in EMPTY status I1108 06:40:21.959635 28031 hierarchical.cpp:140] Initialized hierarchical allocator process I1108 06:40:21.959727 28031 whitelist_watcher.cpp:79] No whitelist given I1108 06:40:21.961144 28036 master.cpp:1606] The newly elected leader is master@172.17.5.214:46896 with id 3e817a91-5c22-4c3c-ab09-684edc18fad3 I1108 06:40:21.961256 28036 master.cpp:1619] Elected as the leading master! I1108 06:40:21.961361 28036 master.cpp:1379] Recovering from registrar I1108 06:40:21.961694 28036 registrar.cpp:309] Recovering registrar I1108 06:40:21.964135 28038 replica.cpp:676] Replica in EMPTY status received a broadcasted recover request from (10521)@172.17.5.214:46896 I1108 06:40:21.964612 28040 recover.cpp:195] Received a recover response from a replica in EMPTY status I1108 06:40:21.965353 28040 recover.cpp:566] Updating replica status to STARTING I1108 06:40:21.966969 28040 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 1.178737ms I1108 06:40:21.967017 28040 replica.cpp:323] Persisted replica status to STARTING I1108 06:40:21.967238 28040 recover.cpp:475] Replica is in STARTING status I1108 06:40:21.968860 28033 replica.cpp:676] Replica in STARTING status received a broadcasted recover request from (10522)@172.17.5.214:46896 I1108 06:40:21.970093 28037 recover.cpp:195] Received a recover response from a replica in STARTING status I1108 06:40:21.970737 28037 recover.cpp:566] Updating replica status to VOTING I1108 06:40:21.971982 28038 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 1.006333ms I1108 06:40:21.972038 28038 replica.cpp:323] Persisted replica status to VOTING I1108 06:40:21.972187 28038 recover.cpp:580] Successfully joined the Paxos group I1108 06:40:21.972379 28038 recover.cpp:464] Recover process terminated I1108 06:40:21.973187 28038 log.cpp:661] Attempting to start the writer I1108 06:40:21.976032 28028 replica.cpp:496] Replica received implicit promise request from (10523)@172.17.5.214:46896 with proposal 1 I1108 06:40:21.976970 28028 leveldb.cpp:306] Persisting metadata (8 bytes) to leveldb took 888091ns I1108 06:40:21.977004 28028 replica.cpp:345] Persisted promised to 1 I1108 06:40:21.978179 28028 coordinator.cpp:240] Coordinator attempting to fill missing positions I1108 06:40:21.979794 28040 replica.cpp:391] Replica received explicit promise request from (10524)@172.17.5.214:46896 for position 0 with proposal 2 I1108 06:40:21.981997 28040 leveldb.cpp:343] Persisting action (8 bytes) to leveldb took 2.040382ms I1108 06:40:21.982064 28040 replica.cpp:715] Persisted action at 0 I1108 06:40:21.983861 28030 replica.cpp:540] Replica received write request for position 0 from (10525)@172.17.5.214:46896 I1108 06:40:21.983999 28030 leveldb.cpp:438] Reading position from leveldb took 71876ns I1108 06:40:21.984513 28030 leveldb.cpp:343] Persisting action (14 bytes) to leveldb took 462712ns I1108 06:40:21.984542 28030 replica.cpp:715] Persisted action at 0 I1108 06:40:21.985270 28031 replica.cpp:694] Replica received learned notice for position 0 from @0.0.0.0:0 I1108 06:40:21.985975 28031 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 662132ns I1108 06:40:21.986012 28031 replica.cpp:715] Persisted action at 0 I1108 06:40:21.986042 28031 replica.cpp:700] Replica learned NOP action at position 0 I1108 06:40:21.987002 28030 log.cpp:677] Writer started with ending position 0 I1108 06:40:21.988415 28030 leveldb.cpp:438] Reading position from leveldb took 96251ns I1108 06:40:21.994503 28032 registrar.cpp:342] Successfully fetched the registry (0B) in 32.65408ms I1108 06:40:21.994680 28032 registrar.cpp:441] Applied 1 operations in 51892ns; attempting to update the 'registry' I1108 06:40:21.995774 28030 log.cpp:685] Attempting to append 176 bytes to the log I1108 06:40:21.996011 28034 coordinator.cpp:350] Coordinator attempting to write APPEND action at position 1 I1108 06:40:21.997036 28036 replica.cpp:540] Replica received write request for position 1 from (10526)@172.17.5.214:46896 I1108 06:40:21.997974 28036 leveldb.cpp:343] Persisting action (195 bytes) to leveldb took 900285ns I1108 06:40:21.998014 28036 replica.cpp:715] Persisted action at 1 I1108 06:40:22.000046 28043 replica.cpp:694] Replica received learned notice for position 1 from @0.0.0.0:0 I1108 06:40:22.000972 28043 leveldb.cpp:343] Persisting action (197 bytes) to leveldb took 892352ns I1108 06:40:22.001003 28043 replica.cpp:715] Persisted action at 1 I1108 06:40:22.001029 28043 replica.cpp:700] Replica learned APPEND action at position 1 I1108 06:40:22.002465 28028 registrar.cpp:486] Successfully updated the 'registry' in 7.702784ms I1108 06:40:22.002640 28028 registrar.cpp:372] Successfully recovered registrar I1108 06:40:22.002740 28040 log.cpp:704] Attempting to truncate the log to 1 I1108 06:40:22.002950 28040 coordinator.cpp:350] Coordinator attempting to write TRUNCATE action at position 2 I1108 06:40:22.003020 28028 master.cpp:1416] Recovered 0 slaves from the Registry (137B) ; allowing 10mins for slaves to re-register I1108 06:40:22.004451 28028 replica.cpp:540] Replica received write request for position 2 from (10527)@172.17.5.214:46896 I1108 06:40:22.005066 28028 leveldb.cpp:343] Persisting action (16 bytes) to leveldb took 586908ns I1108 06:40:22.005094 28028 replica.cpp:715] Persisted action at 2 I1108 06:40:22.006135 28030 replica.cpp:694] Replica received learned notice for position 2 from @0.0.0.0:0 I1108 06:40:22.006582 28030 leveldb.cpp:343] Persisting action (18 bytes) to leveldb took 409642ns I1108 06:40:22.006641 28030 leveldb.cpp:401] Deleting ~1 keys from leveldb took 40758ns I1108 06:40:22.006662 28030 replica.cpp:715] Persisted action at 2 I1108 06:40:22.006691 28030 replica.cpp:700] Replica learned TRUNCATE action at position 2 I1108 06:40:22.015681 28010 scheduler.cpp:156] Version: 0.26.0 I1108 06:40:22.016784 28043 scheduler.cpp:238] New master detected at master@172.17.5.214:46896 I1108 06:40:22.019099 28033 scheduler.cpp:300] Sending SUBSCRIBE call to master@172.17.5.214:46896 I1108 06:40:22.021447 28029 process.cpp:3075] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1108 06:40:22.021720 28029 http.cpp:334] HTTP POST for /master/api/v1/scheduler from 172.17.5.214:54988 I1108 06:40:22.022158 28029 master.cpp:1868] Received subscription request for HTTP framework 'default' I1108 06:40:22.022192 28029 master.cpp:1645] Authorizing framework principal 'test-principal' to receive offers for role '*' I1108 06:40:22.022575 28029 master.cpp:1960] Subscribing framework 'default' with checkpointing disabled and capabilities [ ] I1108 06:40:22.023229 28032 hierarchical.cpp:185] Added framework 3e817a91-5c22-4c3c-ab09-684edc18fad3-0000 I1108 06:40:22.023299 28032 hierarchical.cpp:952] No resources available to allocate! I1108 06:40:22.023334 28032 hierarchical.cpp:1045] No inverse offers to send out! I1108 06:40:22.023355 28032 hierarchical.cpp:851] Performed allocation for 0 slaves in 95202ns I1108 06:40:22.023387 28032 master.hpp:1439] Sending heartbeat to 3e817a91-5c22-4c3c-ab09-684edc18fad3-0000 I1108 06:40:22.025177 28029 scheduler.cpp:459] Enqueuing event SUBSCRIBED received from master@172.17.5.214:46896 I1108 06:40:22.025632 28029 scheduler.cpp:459] Enqueuing event HEARTBEAT received from master@172.17.5.214:46896 I1108 06:40:22.027297 28029 master_maintenance_tests.cpp:174] Ignoring HEARTBEAT event I1108 06:40:22.028230 28037 scheduler.cpp:300] Sending REQUEST call to master@172.17.5.214:46896 I1108 06:40:22.030724 28037 process.cpp:3075] Handling HTTP event for process 'master' with path: '/master/api/v1/scheduler' I1108 06:40:22.030958 28037 http.cpp:334] HTTP POST for /master/api/v1/scheduler from 172.17.5.214:54989 I1108 06:40:22.031251 28037 master.cpp:2615] Processing REQUEST call for framework 3e817a91-5c22-4c3c-ab09-684edc18fad3-0000 (default) I1108 06:40:22.031426 28041 hierarchical.cpp:449] Received resource request from framework 3e817a91-5c22-4c3c-ab09-684edc18fad3-0000 I1108 06:40:22.033028 28042 master.cpp:922] Master terminating I1108 06:40:22.033258 28041 hierarchical.cpp:220] Removed framework 3e817a91-5c22-4c3c-ab09-684edc18fad3-0000 E1108 06:40:22.036408 28033 scheduler.cpp:433] End-Of-File received from master. The master closed the event stream [ OK ] ContentType/SchedulerTest.Request/1 (107 ms) [----------] 22 tests from ContentType/SchedulerTest (5004 ms total) [----------] Global test environment tear-down [==========] 825 tests from 112 test cases ran. (339283 ms total) [ PASSED ] 824 tests. [ FAILED ] 1 test, listed below: [ FAILED ] ExamplesTest.PersistentVolumeFramework 1 FAILED TEST YOU HAVE 7 DISABLED TESTS make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-0.26.0/_build/src' make[3]: Leaving directory `/mesos/mesos-0.26.0/_build/src' make[3]: *** [check-am] Error 2 make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-0.26.0/_build/src' make[1]: Leaving directory `/mesos/mesos-0.26.0/_build' make[1]: *** [check-recursive] Error 1 make: *** [distcheck] Error 1 + docker rmi mesos-1446963088-26890 Untagged: mesos-1446963088-26890:latest Deleted: 2761db5e0d2c35cf1ce247f0b9be0051396ce4dd5326d0ad6123e3636404e457 Deleted: 7815a00812bfd7557837afa7a8e0390e95245c3fb4a0be9bc0a85950480096ec Deleted: d4a118fa62d707988d129e4ce874fa820d19aeb14c01a712340317ee4f5578b4 Deleted: 96c42f3bc8bdd0be065cec96519ea3d4f854d0f0e6aefe7ab64ac42d9b61b395 Deleted: e0ed398a23459d0daea56134cdbe7ed8827e546756bc672b97e70d4aa576bbe5 Deleted: bcae8083edce927fd32ec8da761eb69de6def5d79b8a453d02e96593f86c2d51 Deleted: 870de43405ea34e9e70c2662969767ba1a70beefff2af034b80acd8846201aa3 Deleted: 9cfabf0003bc9c3133ca42c5c1ed0ecea76a3fda7e9f1fb19e04face4fe69fca Deleted: d28de205f94ba8c575b6db0a61c093702ca7715a3bbbae83cd66137b9342ec97 Deleted: f5a8efe16ea5f1ceefa10b1626e24c13aae453533d4c315431c9daf908c82028 Deleted: 8faabe54365eee8173b5f4f5a7f62c99705ed0ca5dee75d2de643ad0a75beceb Deleted: d355387b8f71cf8faa7747b4213a4e5f958fc07c01a97859dcc4628adfb3d005 Deleted: efd9373728f810739098f2aa1cbb6cf269082515cc6d229b5a2bf37ae1a0a69d Build step 'Execute shell' marked build as failure