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 978E0181DF for ; Thu, 18 Feb 2016 19:52:43 +0000 (UTC) Received: (qmail 72995 invoked by uid 500); 18 Feb 2016 19:52:43 -0000 Delivered-To: apmail-mesos-builds-archive@mesos.apache.org Received: (qmail 72964 invoked by uid 500); 18 Feb 2016 19:52:43 -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 72953 invoked by uid 99); 18 Feb 2016 19:52:43 -0000 Received: from crius.apache.org (HELO crius.apache.org) (140.211.11.14) by apache.org (qpsmtpd/0.29) with ESMTP; Thu, 18 Feb 2016 19:52:43 +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 795A99C02EE for ; Thu, 18 Feb 2016 19:52:37 +0000 (UTC) Date: Thu, 18 Feb 2016 19:52:37 +0000 (UTC) From: Apache Jenkins Server To: builds@mesos.apache.org Message-ID: <2015855189.9205.1455825157394.JavaMail.jenkins@crius> Subject: =?UTF-8?Q?Build_failed_in_Jenkins:_Mesos?= =?UTF-8?Q?_=C2=BB_gcc,--verbose,GLOG=5Fv=3D1_MESOS?= =?UTF-8?Q?=5FVERBOSE=3D1,ubuntu:14.04,(docke?= =?UTF-8?Q?r||Hadoop)&&(!ubuntu-us1)_#1684?= MIME-Version: 1.0 Content-Type: text/plain; charset=UTF-8 Content-Transfer-Encoding: quoted-printable X-Instance-Identity: MIIBIjANBgkqhkiG9w0BAQEFAAOCAQ8AMIIBCgKCAQEAkqVKZPv7YyHBB3FvWfV7XQehwe/Ga3aadzSNknt8g382X3uN8A3SOQ+Ixq9HxS+ZlN6XR4TECySmSRy2JN5Rx8svxAD0TjtSF9LuU98dD+LniNDP7Lq6gvRFuJhbMHoS0nuTizDZLsK4X8TW5MyV9w+jFbdoZfRE5O/Mse0fkOeL5uoIS/3Vvu/W+x9QSjDkB7CaU56bPFlQjqqJBl3Cn9r34CkXQZYnLb/NjW4vcpw0+TgMUAPTIVEr5BTPZRshz19g7huwg3zANT5HBIZnzV4hsVY9w4JHkceFdKi/ibNnjPjsFs9pm0HSGJ/RDxjIvSTYT02eH4+m1RAYaj2E9QIDAQAB X-Jenkins-Job: Mesos/COMPILER=gcc,CONFIGURATION=--verbose,ENVIRONMENT=GLOG_v=1 MESOS_VERBOSE=1,OS=ubuntu:14.04,label_exp=(docker||Hadoop)&&(!ubuntu-us1) X-Jenkins-Result: FAILURE See ------------------------------------------ [...truncated 164214 lines...] I0218 19:52:37.031893 799 gc.cpp:54] Scheduling '/tmp/ContentType_Schedul= erTest_Message_1_qXpzOV/slaves/10a6bd11-90ef-4c2b-bd00-2a15062eb28d-S0/fram= eworks/10a6bd11-90ef-4c2b-bd00-2a15062eb28d-0000' for gc 6.99999963853037da= ys in the future [ OK ] ContentType/SchedulerTest.Message/1 (202 ms) [ RUN ] ContentType/SchedulerTest.Request/0 I0218 19:52:37.043962 777 leveldb.cpp:174] Opened db in 2.977776ms I0218 19:52:37.044842 777 leveldb.cpp:181] Compacted db in 812029ns I0218 19:52:37.044908 777 leveldb.cpp:196] Created db iterator in 26015ns I0218 19:52:37.044935 777 leveldb.cpp:202] Seeked to beginning of db in 2= 267ns I0218 19:52:37.044952 777 leveldb.cpp:271] Iterated through 0 keys in the= db in 303ns I0218 19:52:37.045011 777 replica.cpp:779] Replica recovered with log pos= itions 0 -> 0 with 1 holes and 0 unlearned I0218 19:52:37.045819 810 recover.cpp:447] Starting replica recovery I0218 19:52:37.046145 807 recover.cpp:473] Replica is in EMPTY status I0218 19:52:37.048825 811 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (14712)@172.17.0.2:54908 I0218 19:52:37.049062 807 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0218 19:52:37.050375 805 recover.cpp:564] Updating replica status to STA= RTING I0218 19:52:37.051323 801 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 775693ns I0218 19:52:37.051353 801 replica.cpp:320] Persisted replica status to ST= ARTING I0218 19:52:37.051647 801 recover.cpp:473] Replica is in STARTING status I0218 19:52:37.052798 808 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14713)@172.17.0.2:54908 I0218 19:52:37.053673 801 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0218 19:52:37.054111 800 recover.cpp:564] Updating replica status to VOT= ING I0218 19:52:37.054646 807 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 410365ns I0218 19:52:37.054673 807 replica.cpp:320] Persisted replica status to VO= TING I0218 19:52:37.054769 810 recover.cpp:578] Successfully joined the Paxos = group I0218 19:52:37.055001 810 recover.cpp:462] Recover process terminated I0218 19:52:37.055313 796 master.cpp:376] Master 6d1f00f8-5834-4c8f-ad11-= 430d57ba28d9 (79756f9fbbea) started on 172.17.0.2:54908 I0218 19:52:37.055341 796 master.cpp:378] Flags at startup: --acls=3D"" -= -allocation_interval=3D"1secs" --allocator=3D"HierarchicalDRF" --authentica= te=3D"false" --authenticate_http=3D"true" --authenticate_slaves=3D"true" --= authenticators=3D"crammd5" --authorizers=3D"local" --credentials=3D"/tmp/hR= rKjS/credentials" --framework_sorter=3D"drf" --help=3D"false" --hostname_lo= okup=3D"true" --http_authenticators=3D"basic" --initialize_driver_logging= =3D"true" --log_auto_initialize=3D"true" --logbufsecs=3D"0" --logging_level= =3D"INFO" --max_completed_frameworks=3D"50" --max_completed_tasks_per_frame= work=3D"1000" --max_slave_ping_timeouts=3D"5" --quiet=3D"false" --recovery_= slave_removal_limit=3D"100%" --registry=3D"replicated_log" --registry_fetch= _timeout=3D"1mins" --registry_store_timeout=3D"100secs" --registry_strict= =3D"true" --root_submissions=3D"true" --slave_ping_timeout=3D"15secs" --sla= ve_reregister_timeout=3D"10mins" --user_sorter=3D"drf" --version=3D"false" = --webui_dir=3D"/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir=3D"/= tmp/hRrKjS/master" --zk_session_timeout=3D"10secs" I0218 19:52:37.055742 796 master.cpp:425] Master allowing unauthenticated= frameworks to register I0218 19:52:37.055758 796 master.cpp:428] Master only allowing authentica= ted slaves to register I0218 19:52:37.055771 796 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/hRrKjS/credentials' I0218 19:52:37.056177 796 master.cpp:468] Using default 'crammd5' authent= icator I0218 19:52:37.056344 796 master.cpp:537] Using default 'basic' HTTP auth= enticator I0218 19:52:37.056504 796 master.cpp:571] Authorization enabled I0218 19:52:37.056712 807 whitelist_watcher.cpp:77] No whitelist given I0218 19:52:37.056731 809 hierarchical.cpp:144] Initialized hierarchical = allocator process I0218 19:52:37.060174 800 master.cpp:1712] The newly elected leader is ma= ster@172.17.0.2:54908 with id 6d1f00f8-5834-4c8f-ad11-430d57ba28d9 I0218 19:52:37.060207 800 master.cpp:1725] Elected as the leading master! I0218 19:52:37.060226 800 master.cpp:1470] Recovering from registrar I0218 19:52:37.060343 807 registrar.cpp:307] Recovering registrar I0218 19:52:37.061197 809 log.cpp:659] Attempting to start the writer I0218 19:52:37.062604 805 replica.cpp:493] Replica received implicit prom= ise request from (14715)@172.17.0.2:54908 with proposal 1 I0218 19:52:37.063136 805 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 486610ns I0218 19:52:37.063163 805 replica.cpp:342] Persisted promised to 1 I0218 19:52:37.064955 810 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0218 19:52:37.066876 807 replica.cpp:388] Replica received explicit prom= ise request from (14716)@172.17.0.2:54908 for position 0 with proposal 2 I0218 19:52:37.067526 807 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 603819ns I0218 19:52:37.067556 807 replica.cpp:712] Persisted action at 0 I0218 19:52:37.069571 796 replica.cpp:537] Replica received write request= for position 0 from (14717)@172.17.0.2:54908 I0218 19:52:37.069650 796 leveldb.cpp:436] Reading position from leveldb = took 47404ns I0218 19:52:37.070221 796 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 525549ns I0218 19:52:37.070338 796 replica.cpp:712] Persisted action at 0 I0218 19:52:37.071142 800 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0218 19:52:37.071651 800 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 474835ns I0218 19:52:37.071678 800 replica.cpp:712] Persisted action at 0 I0218 19:52:37.071697 800 replica.cpp:697] Replica learned NOP action at = position 0 I0218 19:52:37.072551 800 log.cpp:675] Writer started with ending positio= n 0 I0218 19:52:37.074100 800 leveldb.cpp:436] Reading position from leveldb = took 29080ns I0218 19:52:37.075575 800 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 15.183872ms I0218 19:52:37.075731 800 registrar.cpp:439] Applied 1 operations in 3516= 5ns; attempting to update the 'registry' I0218 19:52:37.076985 802 log.cpp:683] Attempting to append 170 bytes to = the log I0218 19:52:37.077227 800 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0218 19:52:37.081328 809 replica.cpp:537] Replica received write request= for position 1 from (14718)@172.17.0.2:54908 I0218 19:52:37.081972 809 leveldb.cpp:341] Persisting action (189 bytes) = to leveldb took 567858ns I0218 19:52:37.082003 809 replica.cpp:712] Persisted action at 1 I0218 19:52:37.082864 802 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0218 19:52:37.083412 802 leveldb.cpp:341] Persisting action (191 bytes) = to leveldb took 514838ns I0218 19:52:37.083444 802 replica.cpp:712] Persisted action at 1 I0218 19:52:37.083477 802 replica.cpp:697] Replica learned APPEND action = at position 1 I0218 19:52:37.087505 809 log.cpp:702] Attempting to truncate the log to = 1 I0218 19:52:37.087641 804 registrar.cpp:484] Successfully updated the 're= gistry' in 11.805184ms I0218 19:52:37.087837 804 registrar.cpp:370] Successfully recovered regis= trar I0218 19:52:37.087954 802 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0218 19:52:37.088842 802 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0218 19:52:37.088829 809 master.cpp:1522] Recovered 0 slaves from the Re= gistry (131B) ; allowing 10mins for slaves to re-register I0218 19:52:37.089324 811 replica.cpp:537] Replica received write request= for position 2 from (14719)@172.17.0.2:54908 I0218 19:52:37.090692 811 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 1.303157ms I0218 19:52:37.090749 811 replica.cpp:712] Persisted action at 2 I0218 19:52:37.091506 801 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0218 19:52:37.092172 801 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 634750ns I0218 19:52:37.092231 801 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 33503ns I0218 19:52:37.092257 801 replica.cpp:712] Persisted action at 2 I0218 19:52:37.092278 801 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0218 19:52:37.099485 777 scheduler.cpp:154] Version: 0.28.0 I0218 19:52:37.101133 807 scheduler.cpp:236] New master detected at maste= r@172.17.0.2:54908 I0218 19:52:37.102888 803 scheduler.cpp:298] Sending SUBSCRIBE call to ma= ster@172.17.0.2:54908 I0218 19:52:37.106009 801 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0218 19:52:37.106555 801 http.cpp:501] HTTP POST for /master/api/v1/sche= duler from 172.17.0.2:44099 I0218 19:52:37.106793 801 master.cpp:1974] Received subscription request = for HTTP framework 'default' I0218 19:52:37.106859 801 master.cpp:1751] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0218 19:52:37.107512 801 master.cpp:2065] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0218 19:52:37.108539 801 hierarchical.cpp:265] Added framework 6d1f00f8-= 5834-4c8f-ad11-430d57ba28d9-0000 I0218 19:52:37.108768 808 master.hpp:1656] Sending heartbeat to 6d1f00f8-= 5834-4c8f-ad11-430d57ba28d9-0000 I0218 19:52:37.110270 808 scheduler.cpp:457] Enqueuing event SUBSCRIBED r= eceived from master@172.17.0.2:54908 I0218 19:52:37.111081 808 scheduler.cpp:457] Enqueuing event HEARTBEAT re= ceived from master@172.17.0.2:54908 I0218 19:52:37.111778 808 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0218 19:52:37.112155 801 hierarchical.cpp:1403] No resources available t= o allocate! I0218 19:52:37.112268 801 hierarchical.cpp:1498] No inverse offers to sen= d out! I0218 19:52:37.112381 801 hierarchical.cpp:1096] Performed allocation for= 0 slaves in 3.818583ms I0218 19:52:37.112714 804 scheduler.cpp:298] Sending REQUEST call to mast= er@172.17.0.2:54908 I0218 19:52:37.114889 797 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0218 19:52:37.115468 797 http.cpp:501] HTTP POST for /master/api/v1/sche= duler from 172.17.0.2:44100 I0218 19:52:37.115651 797 master.cpp:2719] Processing REQUEST call for fr= amework 6d1f00f8-5834-4c8f-ad11-430d57ba28d9-0000 (default) I0218 19:52:37.115881 798 hierarchical.cpp:589] Received resource request= from framework 6d1f00f8-5834-4c8f-ad11-430d57ba28d9-0000 I0218 19:52:37.116422 777 master.cpp:1027] Master terminating I0218 19:52:37.116627 802 hierarchical.cpp:326] Removed framework 6d1f00f= 8-5834-4c8f-ad11-430d57ba28d9-0000 E0218 19:52:37.118911 811 scheduler.cpp:431] End-Of-File received from ma= ster. The master closed the event stream [ OK ] ContentType/SchedulerTest.Request/0 (87 ms) [ RUN ] ContentType/SchedulerTest.Request/1 I0218 19:52:37.129279 777 leveldb.cpp:174] Opened db in 2.491799ms I0218 19:52:37.130517 777 leveldb.cpp:181] Compacted db in 1.115015ms I0218 19:52:37.130568 777 leveldb.cpp:196] Created db iterator in 21446ns I0218 19:52:37.130584 777 leveldb.cpp:202] Seeked to beginning of db in 2= 385ns I0218 19:52:37.130595 777 leveldb.cpp:271] Iterated through 0 keys in the= db in 263ns I0218 19:52:37.130647 777 replica.cpp:779] Replica recovered with log pos= itions 0 -> 0 with 1 holes and 0 unlearned I0218 19:52:37.132804 802 recover.cpp:447] Starting replica recovery I0218 19:52:37.134142 798 recover.cpp:473] Replica is in EMPTY status I0218 19:52:37.134608 802 master.cpp:376] Master a0711345-ba85-49d1-b30a-= 4c7ca5dc3596 (79756f9fbbea) started on 172.17.0.2:54908 I0218 19:52:37.134639 802 master.cpp:378] Flags at startup: --acls=3D"" -= -allocation_interval=3D"1secs" --allocator=3D"HierarchicalDRF" --authentica= te=3D"false" --authenticate_http=3D"true" --authenticate_slaves=3D"true" --= authenticators=3D"crammd5" --authorizers=3D"local" --credentials=3D"/tmp/qF= ITzR/credentials" --framework_sorter=3D"drf" --help=3D"false" --hostname_lo= okup=3D"true" --http_authenticators=3D"basic" --initialize_driver_logging= =3D"true" --log_auto_initialize=3D"true" --logbufsecs=3D"0" --logging_level= =3D"INFO" --max_completed_frameworks=3D"50" --max_completed_tasks_per_frame= work=3D"1000" --max_slave_ping_timeouts=3D"5" --quiet=3D"false" --recovery_= slave_removal_limit=3D"100%" --registry=3D"replicated_log" --registry_fetch= _timeout=3D"1mins" --registry_store_timeout=3D"100secs" --registry_strict= =3D"true" --root_submissions=3D"true" --slave_ping_timeout=3D"15secs" --sla= ve_reregister_timeout=3D"10mins" --user_sorter=3D"drf" --version=3D"false" = --webui_dir=3D"/mesos/mesos-0.28.0/_inst/share/mesos/webui" --work_dir=3D"/= tmp/qFITzR/master" --zk_session_timeout=3D"10secs" I0218 19:52:37.135002 802 master.cpp:425] Master allowing unauthenticated= frameworks to register I0218 19:52:37.135017 802 master.cpp:428] Master only allowing authentica= ted slaves to register I0218 19:52:37.135028 802 credentials.hpp:35] Loading credentials for aut= hentication from '/tmp/qFITzR/credentials' I0218 19:52:37.135399 802 master.cpp:468] Using default 'crammd5' authent= icator I0218 19:52:37.135560 802 master.cpp:537] Using default 'basic' HTTP auth= enticator I0218 19:52:37.135710 802 master.cpp:571] Authorization enabled I0218 19:52:37.135881 798 whitelist_watcher.cpp:77] No whitelist given I0218 19:52:37.136142 808 replica.cpp:673] Replica in EMPTY status receiv= ed a broadcasted recover request from (14728)@172.17.0.2:54908 I0218 19:52:37.136168 800 hierarchical.cpp:144] Initialized hierarchical = allocator process I0218 19:52:37.136880 805 recover.cpp:193] Received a recover response fr= om a replica in EMPTY status I0218 19:52:37.137462 797 recover.cpp:564] Updating replica status to STA= RTING I0218 19:52:37.138481 797 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 793879ns I0218 19:52:37.138509 797 replica.cpp:320] Persisted replica status to ST= ARTING I0218 19:52:37.138739 797 recover.cpp:473] Replica is in STARTING status I0218 19:52:37.139892 797 master.cpp:1712] The newly elected leader is ma= ster@172.17.0.2:54908 with id a0711345-ba85-49d1-b30a-4c7ca5dc3596 I0218 19:52:37.139937 797 master.cpp:1725] Elected as the leading master! I0218 19:52:37.139957 797 master.cpp:1470] Recovering from registrar I0218 19:52:37.140303 808 registrar.cpp:307] Recovering registrar I0218 19:52:37.141896 810 replica.cpp:673] Replica in STARTING status rec= eived a broadcasted recover request from (14729)@172.17.0.2:54908 I0218 19:52:37.142233 809 recover.cpp:193] Received a recover response fr= om a replica in STARTING status I0218 19:52:37.142873 803 recover.cpp:564] Updating replica status to VOT= ING I0218 19:52:37.143738 803 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 622957ns I0218 19:52:37.143765 803 replica.cpp:320] Persisted replica status to VO= TING I0218 19:52:37.143853 809 recover.cpp:578] Successfully joined the Paxos = group I0218 19:52:37.144423 803 log.cpp:659] Attempting to start the writer I0218 19:52:37.145686 809 recover.cpp:462] Recover process terminated I0218 19:52:37.146031 809 replica.cpp:493] Replica received implicit prom= ise request from (14730)@172.17.0.2:54908 with proposal 1 I0218 19:52:37.146541 809 leveldb.cpp:304] Persisting metadata (8 bytes) = to leveldb took 462152ns I0218 19:52:37.146605 809 replica.cpp:342] Persisted promised to 1 I0218 19:52:37.147454 809 coordinator.cpp:238] Coordinator attempting to = fill missing positions I0218 19:52:37.148912 808 replica.cpp:388] Replica received explicit prom= ise request from (14731)@172.17.0.2:54908 for position 0 with proposal 2 I0218 19:52:37.149471 808 leveldb.cpp:341] Persisting action (8 bytes) to= leveldb took 493284ns I0218 19:52:37.149504 808 replica.cpp:712] Persisted action at 0 I0218 19:52:37.150774 801 replica.cpp:537] Replica received write request= for position 0 from (14732)@172.17.0.2:54908 I0218 19:52:37.150873 801 leveldb.cpp:436] Reading position from leveldb = took 46281ns I0218 19:52:37.151682 801 leveldb.cpp:341] Persisting action (14 bytes) t= o leveldb took 747348ns I0218 19:52:37.151724 801 replica.cpp:712] Persisted action at 0 I0218 19:52:37.152480 797 replica.cpp:691] Replica received learned notic= e for position 0 from @0.0.0.0:0 I0218 19:52:37.152948 797 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 428749ns I0218 19:52:37.152981 797 replica.cpp:712] Persisted action at 0 I0218 19:52:37.153007 797 replica.cpp:697] Replica learned NOP action at = position 0 I0218 19:52:37.153748 806 log.cpp:675] Writer started with ending positio= n 0 I0218 19:52:37.155051 809 leveldb.cpp:436] Reading position from leveldb = took 65679ns I0218 19:52:37.156543 798 registrar.cpp:340] Successfully fetched the reg= istry (0B) in 16.162048ms I0218 19:52:37.156714 798 registrar.cpp:439] Applied 1 operations in 4487= 7ns; attempting to update the 'registry' I0218 19:52:37.157639 808 log.cpp:683] Attempting to append 170 bytes to = the log I0218 19:52:37.157783 804 coordinator.cpp:348] Coordinator attempting to = write APPEND action at position 1 I0218 19:52:37.158860 797 replica.cpp:537] Replica received write request= for position 1 from (14733)@172.17.0.2:54908 I0218 19:52:37.159682 797 leveldb.cpp:341] Persisting action (189 bytes) = to leveldb took 756475ns I0218 19:52:37.159725 797 replica.cpp:712] Persisted action at 1 I0218 19:52:37.160794 797 replica.cpp:691] Replica received learned notic= e for position 1 from @0.0.0.0:0 I0218 19:52:37.161684 797 leveldb.cpp:341] Persisting action (191 bytes) = to leveldb took 839377ns I0218 19:52:37.161726 797 replica.cpp:712] Persisted action at 1 I0218 19:52:37.161763 797 replica.cpp:697] Replica learned APPEND action = at position 1 I0218 19:52:37.163756 799 registrar.cpp:484] Successfully updated the 're= gistry' in 6.956032ms I0218 19:52:37.163991 799 registrar.cpp:370] Successfully recovered regis= trar I0218 19:52:37.164504 799 master.cpp:1522] Recovered 0 slaves from the Re= gistry (131B) ; allowing 10mins for slaves to re-register I0218 19:52:37.164656 811 hierarchical.cpp:171] Skipping recovery of hier= archical allocator: nothing to recover I0218 19:52:37.165379 797 log.cpp:702] Attempting to truncate the log to = 1 I0218 19:52:37.165686 799 coordinator.cpp:348] Coordinator attempting to = write TRUNCATE action at position 2 I0218 19:52:37.167279 799 replica.cpp:537] Replica received write request= for position 2 from (14734)@172.17.0.2:54908 I0218 19:52:37.169704 799 leveldb.cpp:341] Persisting action (16 bytes) t= o leveldb took 2.341826ms I0218 19:52:37.169786 799 replica.cpp:712] Persisted action at 2 I0218 19:52:37.170924 808 replica.cpp:691] Replica received learned notic= e for position 2 from @0.0.0.0:0 I0218 19:52:37.171485 808 leveldb.cpp:341] Persisting action (18 bytes) t= o leveldb took 511096ns I0218 19:52:37.171550 808 leveldb.cpp:399] Deleting ~1 keys from leveldb = took 32534ns I0218 19:52:37.171577 808 replica.cpp:712] Persisted action at 2 I0218 19:52:37.171609 808 replica.cpp:697] Replica learned TRUNCATE actio= n at position 2 I0218 19:52:37.175920 777 scheduler.cpp:154] Version: 0.28.0 I0218 19:52:37.176810 799 scheduler.cpp:236] New master detected at maste= r@172.17.0.2:54908 I0218 19:52:37.179808 796 scheduler.cpp:298] Sending SUBSCRIBE call to ma= ster@172.17.0.2:54908 I0218 19:52:37.182498 804 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0218 19:52:37.183137 798 http.cpp:501] HTTP POST for /master/api/v1/sche= duler from 172.17.0.2:44101 I0218 19:52:37.183640 798 master.cpp:1974] Received subscription request = for HTTP framework 'default' I0218 19:52:37.183719 798 master.cpp:1751] Authorizing framework principa= l 'test-principal' to receive offers for role '*' I0218 19:52:37.184077 804 master.cpp:2065] Subscribing framework 'default= ' with checkpointing disabled and capabilities [ ] I0218 19:52:37.184676 806 hierarchical.cpp:265] Added framework a0711345-= ba85-49d1-b30a-4c7ca5dc3596-0000 I0218 19:52:37.184850 806 hierarchical.cpp:1403] No resources available t= o allocate! I0218 19:52:37.184957 806 hierarchical.cpp:1498] No inverse offers to sen= d out! I0218 19:52:37.185042 806 hierarchical.cpp:1096] Performed allocation for= 0 slaves in 267263ns I0218 19:52:37.185318 804 master.hpp:1656] Sending heartbeat to a0711345-= ba85-49d1-b30a-4c7ca5dc3596-0000 I0218 19:52:37.186214 804 scheduler.cpp:457] Enqueuing event SUBSCRIBED r= eceived from master@172.17.0.2:54908 I0218 19:52:37.187055 804 scheduler.cpp:457] Enqueuing event HEARTBEAT re= ceived from master@172.17.0.2:54908 I0218 19:52:37.187518 804 master_maintenance_tests.cpp:177] Ignoring HEAR= TBEAT event I0218 19:52:37.188666 809 scheduler.cpp:298] Sending REQUEST call to mast= er@172.17.0.2:54908 I0218 19:52:37.191066 797 process.cpp:3141] Handling HTTP event for proce= ss 'master' with path: '/master/api/v1/scheduler' I0218 19:52:37.191671 809 http.cpp:501] HTTP POST for /master/api/v1/sche= duler from 172.17.0.2:44102 I0218 19:52:37.192111 809 master.cpp:2719] Processing REQUEST call for fr= amework a0711345-ba85-49d1-b30a-4c7ca5dc3596-0000 (default) I0218 19:52:37.192365 803 hierarchical.cpp:589] Received resource request= from framework a0711345-ba85-49d1-b30a-4c7ca5dc3596-0000 I0218 19:52:37.193048 805 master.cpp:1027] Master terminating I0218 19:52:37.193361 807 hierarchical.cpp:326] Removed framework a071134= 5-ba85-49d1-b30a-4c7ca5dc3596-0000 E0218 19:52:37.195322 802 scheduler.cpp:431] End-Of-File received from ma= ster. The master closed the event stream [ OK ] ContentType/SchedulerTest.Request/1 (79 ms) [----------] 22 tests from ContentType/SchedulerTest (5594 ms total) [----------] Global test environment tear-down [=3D=3D=3D=3D=3D=3D=3D=3D=3D=3D] 974 tests from 126 test cases ran. (360845= ms total) [ PASSED ] 973 tests. [ FAILED ] 1 test, listed below: [ FAILED ] MasterQuotaTest.AvailableResourcesAfterRescinding 1 FAILED TEST YOU HAVE 7 DISABLED TESTS make[4]: *** [check-local] Error 1 make[4]: Leaving directory `/mesos/mesos-0.28.0/_build/src' make[3]: *** [check-am] Error 2 make[3]: Leaving directory `/mesos/mesos-0.28.0/_build/src' make[2]: *** [check] Error 2 make[2]: Leaving directory `/mesos/mesos-0.28.0/_build/src' make[1]: *** [check-recursive] Error 1 make[1]: Leaving directory `/mesos/mesos-0.28.0/_build' make: *** [distcheck] Error 1 + docker rmi mesos-1455823040-11311 Untagged: mesos-1455823040-11311:latest Deleted: 3b1b0748281522bd7af63a4192bbb5c24864c11dbb696b5da85cb945dc933406 Deleted: dc1b49af9340ed1bb69a8d538cb41d6753b077f43d104111b6bf2f836b2975ba Deleted: 418c3b054ddc0fda8c1609d2a1dabd90522a18806715b22192237182ce96cc76 Deleted: e8aaa004c2ab994c9ed6162387cd2af4b080dbe453e39104a7d7da818012a1bd Deleted: 9cf6e77e1e9ac2d54616832e9ebcf9df24643403b58e1b4ca876656e31ff57fd Deleted: c60e80696c212fe36220250783f5e0528c549a51ddfc14d180ad6cbdcfb6c6dc Deleted: 83f2845e0da4f9798fe45348c9f4f197845d2b140869efa95912826fbd4ec60d Deleted: 34e0b4dd418dd4d41e09f2a55fd8c30716e1a28fdd3f909d4ce1fc951fba9bb4 Deleted: 20c519a13d41799e6cfdcc10dd9911529a9c761608e63bcc5955639a35f0c632 Deleted: 286d92931d3e98ce33386b7709122a70036b3f7d51b00f963944fa9da76b9eb6 Deleted: 656bc6950001468f67d87b0b1c50a204643926e3ecefb2f4590ffec6086c00e2 Deleted: e1793817a15e4ed1fe95ada7f7e95dc82ee8eec3c82c163238a60f88aedad6dd Deleted: 697ba0981484cdab3fada9e62ebd7e557a5f5f37aa6a7b8a8ca1804609f7db3e Deleted: af76d741673693a8d81964a86e6bbe6c12c23cfc4cdde2edac5cf14ec7e6a4f3 Deleted: 38d171f87638c8c1b641b79cb37e9779b7e74e5991c28f9e00326b2f7c6f2364 Deleted: 0b9b6dc7b01b7457671593dbec9860ff37aee87b478afb060ef6a453b3a50af3 Build step 'Execute shell' marked build as failure